builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1450607553.65 results: success (0) buildid: 20151220014831 builduid: 638c7ba2cd204203be8c25b769dc95bf revision: a8e74b6b0511c38b87b6414e99eaa40c75c65205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.651645) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.652164) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.652555) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006401 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.699788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.700120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.733388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.733716) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.787726) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.788048) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.788473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.788786) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 02:32:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-20 02:32:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197042 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.006002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.006441) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.056282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.056684) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a8e74b6b0511c38b87b6414e99eaa40c75c65205 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a8e74b6b0511c38b87b6414e99eaa40c75c65205 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 02:32:34,852 truncating revision to first 12 chars 2015-12-20 02:32:34,853 Setting DEBUG logging. 2015-12-20 02:32:34,853 attempt 1/10 2015-12-20 02:32:34,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a8e74b6b0511?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 02:32:35,139 unpacking tar archive at: fx-team-a8e74b6b0511/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.649765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.650112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.662205) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.662555) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.663026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-20 02:32:34.663438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:35 INFO - MultiFileLogger online at 20151220 02:32:35 in /builds/slave/test 02:32:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:32:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:35 INFO - {'append_to_log': False, 02:32:35 INFO - 'base_work_dir': '/builds/slave/test', 02:32:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:32:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:35 INFO - 'branch': 'Fx-Team-Non-PGO', 02:32:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:35 INFO - 'config_files': ('talos/linux_config.py',), 02:32:35 INFO - 'default_actions': ('clobber', 02:32:35 INFO - 'read-buildbot-config', 02:32:35 INFO - 'download-and-extract', 02:32:35 INFO - 'populate-webroot', 02:32:35 INFO - 'create-virtualenv', 02:32:35 INFO - 'install', 02:32:35 INFO - 'run-tests'), 02:32:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:35 INFO - 'download_minidump_stackwalk': True, 02:32:35 INFO - 'download_symbols': 'ondemand', 02:32:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:35 INFO - 'installer_path': 'installer.exe', 02:32:35 INFO - 'log_level': 'info', 02:32:35 INFO - 'log_name': 'talos', 02:32:35 INFO - 'log_to_console': True, 02:32:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:35 INFO - 'opt_config_files': (), 02:32:35 INFO - 'pip_index': False, 02:32:35 INFO - 'sps_profile': False, 02:32:35 INFO - 'sps_profile_interval': 0, 02:32:35 INFO - 'suite': 'dromaeojs-e10s', 02:32:35 INFO - 'system_bits': '64', 02:32:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:35 INFO - 'title': 'talos-linux64-ix-022', 02:32:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:35 INFO - 'use_talos_json': True, 02:32:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:35 INFO - 'work_dir': 'build'} 02:32:35 INFO - ##### 02:32:35 INFO - ##### Running clobber step. 02:32:35 INFO - ##### 02:32:35 INFO - Running pre-action listener: _resource_record_pre_action 02:32:35 INFO - Running main action method: clobber 02:32:35 INFO - rmtree: /builds/slave/test/build 02:32:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - ##### 02:32:36 INFO - ##### Running read-buildbot-config step. 02:32:36 INFO - ##### 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: read_buildbot_config 02:32:36 INFO - Using buildbot properties: 02:32:36 INFO - { 02:32:36 INFO - "project": "", 02:32:36 INFO - "product": "firefox", 02:32:36 INFO - "script_repo_revision": "production", 02:32:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:32:36 INFO - "repository": "", 02:32:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:32:36 INFO - "buildid": "20151220014831", 02:32:36 INFO - "pgo_build": "False", 02:32:36 INFO - "basedir": "/builds/slave/test", 02:32:36 INFO - "buildnumber": 602, 02:32:36 INFO - "slavename": "talos-linux64-ix-022", 02:32:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:32:36 INFO - "platform": "ubuntu64_hw", 02:32:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:32:36 INFO - "branch": "fx-team", 02:32:36 INFO - "repo_path": "integration/fx-team", 02:32:36 INFO - "revision": "a8e74b6b0511c38b87b6414e99eaa40c75c65205", 02:32:36 INFO - "stage_platform": "linux64", 02:32:36 INFO - "builduid": "638c7ba2cd204203be8c25b769dc95bf", 02:32:36 INFO - "slavebuilddir": "test" 02:32:36 INFO - } 02:32:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - ##### 02:32:36 INFO - ##### Running download-and-extract step. 02:32:36 INFO - ##### 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: download_and_extract 02:32:36 INFO - mkdir: /builds/slave/test/build/tests 02:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:36 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json 02:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json 02:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:32:41 INFO - Downloaded 1302 bytes. 02:32:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:32:41 INFO - Using the following test package requirements: 02:32:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'jsshell-linux-x86_64.zip'], 02:32:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:32:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:32:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:41 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:56 INFO - Downloaded 21872076 bytes. 02:32:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:32:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:32:57 INFO - Return code: 0 02:32:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:57 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:58 INFO - Downloaded 21872076 bytes. 02:32:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:32:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:32:59 INFO - Return code: 0 02:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:59 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:33:00 INFO - Downloaded 11132039 bytes. 02:33:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:33:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:33:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:33:00 INFO - Return code: 0 02:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:00 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:33:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:33:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:33:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:33:02 INFO - Downloaded 53059792 bytes. 02:33:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:33:02 INFO - mkdir: /builds/slave/test/properties 02:33:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:02 INFO - Contents: 02:33:02 INFO - build_url:https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:33:02 INFO - Running post-action listener: _resource_record_post_action 02:33:02 INFO - Running post-action listener: set_extra_try_arguments 02:33:02 INFO - ##### 02:33:02 INFO - ##### Running populate-webroot step. 02:33:02 INFO - ##### 02:33:02 INFO - Running pre-action listener: _resource_record_pre_action 02:33:02 INFO - Running main action method: populate_webroot 02:33:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:02 INFO - '--tppagecycles', 02:33:02 INFO - '7'], 02:33:02 INFO - 'tests': ['tsvgm']}}, 02:33:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:33:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:33:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:33:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'tests': ['damp', 'tps']}, 02:33:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['damp', 'tps']}, 02:33:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:33:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:02 INFO - 'other': {'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'other_l64': {'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'other_nol64': {'tests': ['a11yr', 02:33:02 INFO - 'ts_paint', 02:33:02 INFO - 'tpaint', 02:33:02 INFO - 'sessionrestore', 02:33:02 INFO - 'sessionrestore_no_auto_restore']}, 02:33:02 INFO - 'svgr': {'tests': ['tsvgx', 02:33:02 INFO - 'tsvgr_opacity', 02:33:02 INFO - 'tart', 02:33:02 INFO - 'tscrollx', 02:33:02 INFO - 'cart']}, 02:33:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['tsvgx', 02:33:02 INFO - 'tsvgr_opacity', 02:33:02 INFO - 'tart', 02:33:02 INFO - 'tscrollx', 02:33:02 INFO - 'cart']}, 02:33:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'tests': ['tp5o']}, 02:33:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'talos_options': ['--e10s'], 02:33:02 INFO - 'tests': ['tp5o']}, 02:33:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'talos_options': ['--xperf_path', 02:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:02 INFO - 'tests': ['tp5n']}, 02:33:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:02 INFO - 'talos_options': ['--e10s', 02:33:02 INFO - '--xperf_path', 02:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:02 INFO - 'tests': ['tp5n']}}, 02:33:02 INFO - 'talos.zip': {'path': '', 02:33:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:02 INFO - Running post-action listener: _resource_record_post_action 02:33:02 INFO - ##### 02:33:02 INFO - ##### Running create-virtualenv step. 02:33:02 INFO - ##### 02:33:02 INFO - Running pre-action listener: _resource_record_pre_action 02:33:02 INFO - Running main action method: create_virtualenv 02:33:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:33:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:02 INFO - Using real prefix '/usr' 02:33:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:04 INFO - Installing pip.................done. 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:33:05 INFO - Using env: {'DISPLAY': ':0', 02:33:05 INFO - 'HOME': '/home/cltbld', 02:33:05 INFO - 'LANG': 'en_US.UTF-8', 02:33:05 INFO - 'LANGUAGE': 'en_US:en', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MAIL': '/var/mail/cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SHLVL': '1', 02:33:05 INFO - 'TERM': 'linux', 02:33:05 INFO - 'TMOUT': '86400', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - '_': '/tools/buildbot/bin/python'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:33:05 INFO - Using env: {'DISPLAY': ':0', 02:33:05 INFO - 'HOME': '/home/cltbld', 02:33:05 INFO - 'LANG': 'en_US.UTF-8', 02:33:05 INFO - 'LANGUAGE': 'en_US:en', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MAIL': '/var/mail/cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SHLVL': '1', 02:33:05 INFO - 'TERM': 'linux', 02:33:05 INFO - 'TMOUT': '86400', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - '_': '/tools/buildbot/bin/python'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Downloading/unpacking psutil>=0.7.1 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:33:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:07 INFO - Installing collected packages: psutil 02:33:07 INFO - Running setup.py install for psutil 02:33:07 INFO - building 'psutil._psutil_linux' extension 02:33:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:33:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:33:07 INFO - building 'psutil._psutil_posix' extension 02:33:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:33:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:07 INFO - Successfully installed psutil 02:33:07 INFO - Cleaning up... 02:33:07 INFO - Return code: 0 02:33:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:33:07 INFO - Using env: {'DISPLAY': ':0', 02:33:07 INFO - 'HOME': '/home/cltbld', 02:33:07 INFO - 'LANG': 'en_US.UTF-8', 02:33:07 INFO - 'LANGUAGE': 'en_US:en', 02:33:07 INFO - 'LOGNAME': 'cltbld', 02:33:07 INFO - 'MAIL': '/var/mail/cltbld', 02:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:07 INFO - 'MOZ_NO_REMOTE': '1', 02:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:07 INFO - 'NO_EM_RESTART': '1', 02:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:07 INFO - 'PWD': '/builds/slave/test', 02:33:07 INFO - 'SHELL': '/bin/bash', 02:33:07 INFO - 'SHLVL': '1', 02:33:07 INFO - 'TERM': 'linux', 02:33:07 INFO - 'TMOUT': '86400', 02:33:07 INFO - 'USER': 'cltbld', 02:33:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:07 INFO - '_': '/tools/buildbot/bin/python'} 02:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:09 INFO - Installing collected packages: mozsystemmonitor 02:33:09 INFO - Running setup.py install for mozsystemmonitor 02:33:09 INFO - Successfully installed mozsystemmonitor 02:33:09 INFO - Cleaning up... 02:33:09 INFO - Return code: 0 02:33:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:09 INFO - Using env: {'DISPLAY': ':0', 02:33:09 INFO - 'HOME': '/home/cltbld', 02:33:09 INFO - 'LANG': 'en_US.UTF-8', 02:33:09 INFO - 'LANGUAGE': 'en_US:en', 02:33:09 INFO - 'LOGNAME': 'cltbld', 02:33:09 INFO - 'MAIL': '/var/mail/cltbld', 02:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:09 INFO - 'MOZ_NO_REMOTE': '1', 02:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:09 INFO - 'NO_EM_RESTART': '1', 02:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:09 INFO - 'PWD': '/builds/slave/test', 02:33:09 INFO - 'SHELL': '/bin/bash', 02:33:09 INFO - 'SHLVL': '1', 02:33:09 INFO - 'TERM': 'linux', 02:33:09 INFO - 'TMOUT': '86400', 02:33:09 INFO - 'USER': 'cltbld', 02:33:09 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:09 INFO - '_': '/tools/buildbot/bin/python'} 02:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:12 INFO - Downloading docopt-0.6.1.tar.gz 02:33:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:12 INFO - Running setup.py install for blobuploader 02:33:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:12 INFO - Running setup.py install for requests 02:33:12 INFO - Running setup.py install for docopt 02:33:13 INFO - Successfully installed blobuploader requests docopt 02:33:13 INFO - Cleaning up... 02:33:13 INFO - Return code: 0 02:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:13 INFO - Using env: {'DISPLAY': ':0', 02:33:13 INFO - 'HOME': '/home/cltbld', 02:33:13 INFO - 'LANG': 'en_US.UTF-8', 02:33:13 INFO - 'LANGUAGE': 'en_US:en', 02:33:13 INFO - 'LOGNAME': 'cltbld', 02:33:13 INFO - 'MAIL': '/var/mail/cltbld', 02:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:13 INFO - 'MOZ_NO_REMOTE': '1', 02:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:13 INFO - 'NO_EM_RESTART': '1', 02:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:13 INFO - 'PWD': '/builds/slave/test', 02:33:13 INFO - 'SHELL': '/bin/bash', 02:33:13 INFO - 'SHLVL': '1', 02:33:13 INFO - 'TERM': 'linux', 02:33:13 INFO - 'TMOUT': '86400', 02:33:13 INFO - 'USER': 'cltbld', 02:33:13 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:13 INFO - '_': '/tools/buildbot/bin/python'} 02:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:13 INFO - Running setup.py (path:/tmp/pip-qhTpuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:13 INFO - Running setup.py (path:/tmp/pip-_WXK1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:13 INFO - Running setup.py (path:/tmp/pip-f7hkGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:13 INFO - Running setup.py (path:/tmp/pip-lL9dvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:13 INFO - Running setup.py (path:/tmp/pip-lOJDiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:13 INFO - Running setup.py (path:/tmp/pip-JJ066D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:13 INFO - Running setup.py (path:/tmp/pip-RYCkaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:13 INFO - Running setup.py (path:/tmp/pip-PwgKRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:13 INFO - Running setup.py (path:/tmp/pip-AHOrlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:13 INFO - Running setup.py (path:/tmp/pip-Be9QBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:13 INFO - Running setup.py (path:/tmp/pip-MinxQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:14 INFO - Running setup.py (path:/tmp/pip-2LKt7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:14 INFO - Running setup.py (path:/tmp/pip-5TWo1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:14 INFO - Running setup.py (path:/tmp/pip-KOpH_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:14 INFO - Running setup.py (path:/tmp/pip-lsmN54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:14 INFO - Running setup.py (path:/tmp/pip-ZWrFsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:14 INFO - Running setup.py (path:/tmp/pip-gNkeUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:14 INFO - Running setup.py install for manifestparser 02:33:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozcrash 02:33:14 INFO - Running setup.py install for mozdebug 02:33:14 INFO - Running setup.py install for mozdevice 02:33:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozfile 02:33:15 INFO - Running setup.py install for mozhttpd 02:33:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozinfo 02:33:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozInstall 02:33:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozleak 02:33:15 INFO - Running setup.py install for mozlog 02:33:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for moznetwork 02:33:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozprocess 02:33:15 INFO - Running setup.py install for mozprofile 02:33:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozrunner 02:33:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozscreenshot 02:33:16 INFO - Running setup.py install for moztest 02:33:16 INFO - Running setup.py install for mozversion 02:33:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:16 INFO - Cleaning up... 02:33:16 INFO - Return code: 0 02:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:16 INFO - Using env: {'DISPLAY': ':0', 02:33:16 INFO - 'HOME': '/home/cltbld', 02:33:16 INFO - 'LANG': 'en_US.UTF-8', 02:33:16 INFO - 'LANGUAGE': 'en_US:en', 02:33:16 INFO - 'LOGNAME': 'cltbld', 02:33:16 INFO - 'MAIL': '/var/mail/cltbld', 02:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:16 INFO - 'MOZ_NO_REMOTE': '1', 02:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:16 INFO - 'NO_EM_RESTART': '1', 02:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:16 INFO - 'PWD': '/builds/slave/test', 02:33:16 INFO - 'SHELL': '/bin/bash', 02:33:16 INFO - 'SHLVL': '1', 02:33:16 INFO - 'TERM': 'linux', 02:33:16 INFO - 'TMOUT': '86400', 02:33:16 INFO - 'USER': 'cltbld', 02:33:16 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:16 INFO - '_': '/tools/buildbot/bin/python'} 02:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:16 INFO - Running setup.py (path:/tmp/pip-fOdSi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:16 INFO - Running setup.py (path:/tmp/pip-kZVXMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:16 INFO - Running setup.py (path:/tmp/pip-RiC8p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:16 INFO - Running setup.py (path:/tmp/pip-MCr_rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:16 INFO - Running setup.py (path:/tmp/pip-M4rNs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:16 INFO - Running setup.py (path:/tmp/pip-zYN9iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:16 INFO - Running setup.py (path:/tmp/pip-Q15Ir1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:16 INFO - Running setup.py (path:/tmp/pip-Fr3u1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:17 INFO - Running setup.py (path:/tmp/pip-VDO96G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:17 INFO - Running setup.py (path:/tmp/pip-oCWFwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:17 INFO - Running setup.py (path:/tmp/pip-wdFyZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:17 INFO - Running setup.py (path:/tmp/pip-ZzhsAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:17 INFO - Running setup.py (path:/tmp/pip-gFX5oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:17 INFO - Running setup.py (path:/tmp/pip-PmyV5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:17 INFO - Running setup.py (path:/tmp/pip-HkZe1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:17 INFO - Running setup.py (path:/tmp/pip-pfi8JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:17 INFO - Running setup.py (path:/tmp/pip-yZQwYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:19 INFO - Downloading blessings-1.5.1.tar.gz 02:33:19 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:19 INFO - Installing collected packages: blessings 02:33:19 INFO - Running setup.py install for blessings 02:33:19 INFO - Successfully installed blessings 02:33:19 INFO - Cleaning up... 02:33:19 INFO - Return code: 0 02:33:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:19 INFO - Reading from file tmpfile_stdout 02:33:19 INFO - Current package versions: 02:33:19 INFO - argparse == 1.2.1 02:33:19 INFO - blessings == 1.5.1 02:33:19 INFO - blobuploader == 1.2.4 02:33:19 INFO - docopt == 0.6.1 02:33:19 INFO - manifestparser == 1.1 02:33:19 INFO - mozInstall == 1.12 02:33:19 INFO - mozcrash == 0.16 02:33:19 INFO - mozdebug == 0.1 02:33:19 INFO - mozdevice == 0.47 02:33:19 INFO - mozfile == 1.2 02:33:19 INFO - mozhttpd == 0.7 02:33:19 INFO - mozinfo == 0.9 02:33:19 INFO - mozleak == 0.1 02:33:19 INFO - mozlog == 3.1 02:33:19 INFO - moznetwork == 0.27 02:33:19 INFO - mozprocess == 0.22 02:33:19 INFO - mozprofile == 0.27 02:33:19 INFO - mozrunner == 6.11 02:33:19 INFO - mozscreenshot == 0.1 02:33:19 INFO - mozsystemmonitor == 0.0 02:33:19 INFO - moztest == 0.7 02:33:19 INFO - mozversion == 1.4 02:33:19 INFO - psutil == 3.1.1 02:33:19 INFO - requests == 1.2.3 02:33:19 INFO - wsgiref == 0.1.2 02:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:19 INFO - Using env: {'DISPLAY': ':0', 02:33:19 INFO - 'HOME': '/home/cltbld', 02:33:19 INFO - 'LANG': 'en_US.UTF-8', 02:33:19 INFO - 'LANGUAGE': 'en_US:en', 02:33:19 INFO - 'LOGNAME': 'cltbld', 02:33:19 INFO - 'MAIL': '/var/mail/cltbld', 02:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:19 INFO - 'MOZ_NO_REMOTE': '1', 02:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:19 INFO - 'NO_EM_RESTART': '1', 02:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:19 INFO - 'PWD': '/builds/slave/test', 02:33:19 INFO - 'SHELL': '/bin/bash', 02:33:19 INFO - 'SHLVL': '1', 02:33:19 INFO - 'TERM': 'linux', 02:33:19 INFO - 'TMOUT': '86400', 02:33:19 INFO - 'USER': 'cltbld', 02:33:19 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:19 INFO - '_': '/tools/buildbot/bin/python'} 02:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:20 INFO - Cleaning up... 02:33:20 INFO - Return code: 0 02:33:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:33:20 INFO - Using env: {'DISPLAY': ':0', 02:33:20 INFO - 'HOME': '/home/cltbld', 02:33:20 INFO - 'LANG': 'en_US.UTF-8', 02:33:20 INFO - 'LANGUAGE': 'en_US:en', 02:33:20 INFO - 'LOGNAME': 'cltbld', 02:33:20 INFO - 'MAIL': '/var/mail/cltbld', 02:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:20 INFO - 'MOZ_NO_REMOTE': '1', 02:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:20 INFO - 'NO_EM_RESTART': '1', 02:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:20 INFO - 'PWD': '/builds/slave/test', 02:33:20 INFO - 'SHELL': '/bin/bash', 02:33:20 INFO - 'SHLVL': '1', 02:33:20 INFO - 'TERM': 'linux', 02:33:20 INFO - 'TMOUT': '86400', 02:33:20 INFO - 'USER': 'cltbld', 02:33:20 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:20 INFO - '_': '/tools/buildbot/bin/python'} 02:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:20 INFO - Downloading/unpacking jsonschema 02:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:33:21 INFO - Downloading/unpacking functools32 (from jsonschema) 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:22 INFO - warning: no files found matching '*.txt' 02:33:22 INFO - no previously-included directories found matching 'build' 02:33:22 INFO - no previously-included directories found matching 'dist' 02:33:22 INFO - no previously-included directories found matching '.git*' 02:33:22 INFO - Installing collected packages: jsonschema, functools32 02:33:22 INFO - Running setup.py install for functools32 02:33:22 INFO - warning: no files found matching '*.txt' 02:33:22 INFO - no previously-included directories found matching 'build' 02:33:22 INFO - no previously-included directories found matching 'dist' 02:33:22 INFO - no previously-included directories found matching '.git*' 02:33:22 INFO - Successfully installed jsonschema functools32 02:33:22 INFO - Cleaning up... 02:33:22 INFO - Return code: 0 02:33:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ce0606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:33:22 INFO - Using env: {'DISPLAY': ':0', 02:33:22 INFO - 'HOME': '/home/cltbld', 02:33:22 INFO - 'LANG': 'en_US.UTF-8', 02:33:22 INFO - 'LANGUAGE': 'en_US:en', 02:33:22 INFO - 'LOGNAME': 'cltbld', 02:33:22 INFO - 'MAIL': '/var/mail/cltbld', 02:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:22 INFO - 'MOZ_NO_REMOTE': '1', 02:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:22 INFO - 'NO_EM_RESTART': '1', 02:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:22 INFO - 'PWD': '/builds/slave/test', 02:33:22 INFO - 'SHELL': '/bin/bash', 02:33:22 INFO - 'SHLVL': '1', 02:33:22 INFO - 'TERM': 'linux', 02:33:22 INFO - 'TMOUT': '86400', 02:33:22 INFO - 'USER': 'cltbld', 02:33:22 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:22 INFO - '_': '/tools/buildbot/bin/python'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:22 INFO - Downloading/unpacking flake8 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:33:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:33:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:33:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:33:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:33:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:33:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:24 INFO - no previously-included directories found matching 'docs/_build' 02:33:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:33:25 INFO - Running setup.py install for pep8 02:33:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:25 INFO - no previously-included directories found matching 'docs/_build' 02:33:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:33:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:33:25 INFO - Cleaning up... 02:33:25 INFO - Return code: 0 02:33:25 INFO - Running post-action listener: _resource_record_post_action 02:33:25 INFO - Running post-action listener: _start_resource_monitoring 02:33:25 INFO - Starting resource monitoring. 02:33:25 INFO - ##### 02:33:25 INFO - ##### Running install step. 02:33:25 INFO - ##### 02:33:25 INFO - Running pre-action listener: _resource_record_pre_action 02:33:25 INFO - Running main action method: install 02:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:25 INFO - Reading from file tmpfile_stdout 02:33:25 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:25 INFO - Reading from file tmpfile_stdout 02:33:25 INFO - Output received: 02:33:25 INFO - Usage: mozinstall [options] installer 02:33:25 INFO - Options: 02:33:25 INFO - -h, --help show this help message and exit 02:33:25 INFO - -d DEST, --destination=DEST 02:33:25 INFO - Directory to install application into. [default: 02:33:25 INFO - "/builds/slave/test"] 02:33:25 INFO - --app=APP Application being installed. [default: firefox] 02:33:25 INFO - mkdir: /builds/slave/test/build/application 02:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Output received: 02:33:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:41 INFO - Running post-action listener: _resource_record_post_action 02:33:41 INFO - ##### 02:33:41 INFO - ##### Running run-tests step. 02:33:41 INFO - ##### 02:33:41 INFO - Running pre-action listener: _resource_record_pre_action 02:33:41 INFO - Running main action method: run_tests 02:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:41 INFO - Python 2.7.3 02:33:41 INFO - Return code: 0 02:33:41 INFO - grabbing minidump binary from tooltool 02:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:33:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:33:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:41 INFO - Return code: 0 02:33:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:33:42 INFO - Return code: 0 02:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 02:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 02:33:42 INFO - Using env: {'DISPLAY': ':0', 02:33:42 INFO - 'HOME': '/home/cltbld', 02:33:42 INFO - 'LANG': 'en_US.UTF-8', 02:33:42 INFO - 'LANGUAGE': 'en_US:en', 02:33:42 INFO - 'LOGNAME': 'cltbld', 02:33:42 INFO - 'MAIL': '/var/mail/cltbld', 02:33:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:42 INFO - 'MOZ_NO_REMOTE': '1', 02:33:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:42 INFO - 'NO_EM_RESTART': '1', 02:33:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:42 INFO - 'PWD': '/builds/slave/test', 02:33:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:42 INFO - 'SHELL': '/bin/bash', 02:33:42 INFO - 'SHLVL': '1', 02:33:42 INFO - 'TERM': 'linux', 02:33:42 INFO - 'TMOUT': '86400', 02:33:42 INFO - 'USER': 'cltbld', 02:33:42 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185', 02:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:42 INFO - '_': '/tools/buildbot/bin/python'} 02:33:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 02:33:42 INFO - mozversion INFO | application_buildid: 20151220014831 02:33:42 INFO - mozversion INFO | application_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 02:33:42 INFO - mozversion INFO | application_display_name: Nightly 02:33:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:42 INFO - mozversion INFO | application_name: Firefox 02:33:42 INFO - mozversion INFO | application_remotingname: firefox 02:33:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:33:42 INFO - mozversion INFO | application_vendor: Mozilla 02:33:42 INFO - mozversion INFO | application_version: 46.0a1 02:33:42 INFO - mozversion INFO | platform_buildid: 20151220014831 02:33:42 INFO - mozversion INFO | platform_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 02:33:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:33:42 INFO - mozversion INFO | platform_version: 46.0a1 02:33:42 INFO - 2015-12-20 02:33:42,224 DEBUG : using testdate: 1450607622 02:33:42 INFO - 2015-12-20 02:33:42,224 DEBUG : actual date: 1450607622 02:33:42 INFO - 2015-12-20 02:33:42,272 INFO : starting webserver on 'localhost:51957' 02:33:42 INFO - 2015-12-20 02:33:42,273 INFO : Starting test suite talos-linux64-ix-022.e 02:33:42 INFO - 2015-12-20 02:33:42,273 INFO : Starting test dromaeo_css 02:33:42 INFO - 2015-12-20 02:33:42,273 DEBUG : operating with platform_type : linux_ 02:33:42 INFO - 2015-12-20 02:33:42,274 INFO : Initialising browser for dromaeo_css test... 02:33:42 INFO - 2015-12-20 02:33:42,291 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaKOlyu/profile http://localhost:51957/getInfo.html 02:33:46 INFO - 2015-12-20 02:33:46,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:33:47 INFO - 2015-12-20 02:33:47,482 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:33:47 INFO - 2015-12-20 02:33:47,482 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:33:47 INFO - 2015-12-20 02:33:47,482 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:33:47 INFO - 2015-12-20 02:33:47,482 DEBUG : BROWSER_OUTPUT: __metrics 02:33:47 INFO - 2015-12-20 02:33:47,639 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:33:48 INFO - 2015-12-20 02:33:48,581 INFO : Browser initialized. 02:33:48 INFO - 2015-12-20 02:33:48,582 INFO : Running cycle 1/1 for dromaeo_css test... 02:33:48 INFO - 2015-12-20 02:33:48,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaKOlyu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:00 INFO - 2015-12-20 02:34:00,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 151126016 02:34:00 INFO - 2015-12-20 02:34:00,660 DEBUG : BROWSER_OUTPUT: 02:34:50 INFO - 2015-12-20 02:34:50,268 DEBUG : BROWSER_OUTPUT: 1450607690268 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:37:02 INFO - 2015-12-20 02:37:02,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51957/tests/dromaeo/cssquery-ext.html) 02:37:03 INFO - 2015-12-20 02:37:03,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 154329088 02:37:03 INFO - 2015-12-20 02:37:03,639 DEBUG : BROWSER_OUTPUT: 02:40:05 INFO - 2015-12-20 02:40:05,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-ext.html (next: http://localhost:51957/tests/dromaeo/cssquery-jquery.html) 02:40:06 INFO - 2015-12-20 02:40:06,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 152784896 02:40:06 INFO - 2015-12-20 02:40:06,357 DEBUG : BROWSER_OUTPUT: 02:43:08 INFO - 2015-12-20 02:43:08,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51957/tests/dromaeo/cssquery-mootools.html) 02:43:08 INFO - 2015-12-20 02:43:08,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 154251264 02:43:08 INFO - 2015-12-20 02:43:08,799 DEBUG : BROWSER_OUTPUT: 02:46:10 INFO - 2015-12-20 02:46:10,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51957/tests/dromaeo/cssquery-prototype.html) 02:46:11 INFO - 2015-12-20 02:46:11,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 152850432 02:46:11 INFO - 2015-12-20 02:46:11,131 DEBUG : BROWSER_OUTPUT: 02:49:13 INFO - 2015-12-20 02:49:13,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51957/tests/dromaeo/cssquery-yui.html) 02:49:14 INFO - 2015-12-20 02:49:14,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 152973312 02:49:14 INFO - 2015-12-20 02:49:14,278 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/dromaeo/cssquery-yui.html (next: http://localhost:51957/tests/dromaeo/cssquery-dojo.html) 02:52:16 INFO - 2015-12-20 02:52:16,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 155873280 02:52:16 INFO - 2015-12-20 02:52:16,785 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,785 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:52:16 INFO - 2015-12-20 02:52:16,785 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:52:16 INFO - 2015-12-20 02:52:16,785 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:52:16 INFO - 2015-12-20 02:52:16,786 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:52:16 INFO - 2015-12-20 02:52:16,787 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2702.1488231207168;2748.2579703480046;2763.8341699498033;2786.4566409550134;2788.135677939839;4659.557342052508;4897.04507621014;4925.5813255873245;4937.604991600672;4967.180415231487;4698.577128058474;4719.740414277213;4754.191787396151;4852.3206751054795;4883.340748998884;4432.423784907957;4495.43807024122;4542.636589072867;4579.473360563527;4617.676762626617;4373.650107991369;4444.666650001247;4526.8868278292975;4550.476695180047;4583.220852455074;4256;4354.738715677069;4362.8691139265875;4447.955520444786;4522.6155776759015;4339.500957389909;4359.324304732771;4414.889627759299;4420.911581768379;4434.556544345572;4368.301071828492;4369;4379.562043795627;4416.315471101984;4421.447319085114;4520.208963431386;4623.445186577598;4630.027694184226;4646.79089440976;4670.556297151799;4991.800327986876;4998.750062496897;5022.974885125587;5028.7988480460735;5050.696958182521;5137.152369858969;5146.0479811235045;5173.663711858717;5224.947750522484;5236.764345604457;4843.467218606021;4862.51374862518;4862.6353023523025;4863.124637565272;4888.095702295087;5050.924236136461;5150.639455238173;5265.473452654781;5346.5455436287575;5348.090824559834;5068.290439338495;5070.61970352225;5070.847874563769;5101.566366858859;5226.973865130726;5137.152369858932;5140.008432748873;5152.562032227228;5167.9224811627855;5192.3769147702515;4802.471728109905;4975.800967961241;5047.924281135786;5102.36220472441;5169.4572069932865;5126.897462050738;5136.922946155811;5144.7942082316285;5145.922811157836;5158.716270605078;4288.807003684841;4290.077633308853;4294.162638285567;4329.480462344539;4341.630961368256;3605.3330133925306;3708.054446116223;3714.33142034431;3767.2653832502397;3811.7712937223855;4434.822607095744;4435.933460998088;4462.933056004163;4491.124230774967;4508.706934049276;4921.8523444296725;5189.325387699575;5192.402873669501;5202.089634314056;5202.219667049897;4378.190034843564;4392.077663690597;4395.1429471252795;4400.1199760047475;4437.156940181355;4562.133194692998;4618.237990731559;4627.629789616823;4654.953450465519;4697.882552936204;4907.214845624683;4907.631927605373;4940.92588611164;4949.90100197994;5013.674111182689;4905.166121759381;5029.170186919117;5254.9474505255985;5288.9735551322;5381.434949330421;4885.8045678172475;4965.702057876539;4972.975135124301;4974.253861920741;5009.974950125226;4789.281607758725;5161.509656582619;5187.688738675692;5191.32512773337;5195.532402083831;4986.077575648516;5082.923756143735;5138.177891537336;5163.044836705221;5203.089459344524;4992.675476094042;5030.195168773125;5032.6477146600855;5041.0422019816115;5069.847904562869;4768.856934291838;4932.580730637793;5006.4743201963265;5023.6985780853265;5033.622478314214;4865.805367785249;4877.3903262092235;4898.461169271306;4950.45544990058;4985.1276026695905;5033.169527028146;5062.291279220985;5071.112555302733;5081.542661160365;5090.974545127398;4674.135284972291;4934.901301974012;4944.554990050912;4957.082939656175;4987.2768448574025 02:52:16 INFO - 2015-12-20 02:52:16,787 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.8448921954603;573.260493962788;577.5437404450485;578.0750798722044;584.0509172594534;34621.30757384854;35222.119447013836;35260.64739352606;35287;35321.82339088307;39344.409833852515;39823.601763982355;39832.40251396224;39853.80073099631;40003;7938.761837144895;8078.919210807875;8102.473339232961;8117.878231826528;8126.10612832588;7867.134615192324;7921.36629069673;7987.201279872024;8017.518948863058;8022.839543209132;7911.090224624156;7958.960205198995;7983.920160798376;8015.639296231654;8021.879671804928;7719.768406947773;7763.72826951054;7771.494852834548;7797.337226335769;7801.5709135997495;7901.841963160762;8017;8046.919530804676;8057.838843223161;8064.193580641948;35834.28331433383;36449.81775091134;36567.26865462703;36582.08544786375;36712;2422.573435504475;2936.398038402144;2970.8366039867797;3100.5039193728894;3143.3556120995368;26395.604065939027;30213.395732085235;31315.686843131505;31372.843135784176;32737.672623273702;3135.1221657935816;3140.7487401007866;3152.653208147102;3165.2878102427;3183.4588120019653;176791.11604441894;177649;178056;178629.9999999987;178632;49094;49112;49209;50304.74847625739;51756;63154;64304;64419.35580644134;64499.77501124925;64578;13005.21968681882;13184;13271.867281327257;13307.401166947511;13317.600471985856;10793.298435601819;10906.127509799197;10937.507812148473;10963;10988.120950323955;18089.54776130581;18404.35584754554;18415.90792046031;18453.354132605295;18464.446066618024;6871.415929646036;7074.646267686595;7133.5719856808755;7140.6072666003865;7261.164966028869;821.3100995164091;839.345310657688;943.8253923024263;1023.81059503992;1032.2980373346197;24339.756602434103;24477.755222447548;24558.386040349134;24594.385140371276;24612.261632150705;926.6478738079487;947.5262368815593;1076.1659713721929;1090.7436752363187;1111.1999360460457;12909.225446473241;13074.757897999674;13092.923163056674;13254.469821207236;13424.530141445002;322982;328890;331584;331743;332952;46598.301025484645;47083.529164707914;47306;47338.5266147341;47516.762416187696;1200.7298357869583;1211.5638370186725;1223.687959570304;1234.919730217515;1241.8385609870659;23833.88083059643;23845.258118773698;29383.55924661089;29966.400671986874;30401.391972159992;43630.34554481622;44213.33679994867;44327.556724433634;44373.33439998467;44381.556184437744;247791;250459;252143;252156;252267;38405;38528;38758.224835502566;38773.612263877;38997.2200555993;35782.64217357793;38044.23911521699;38192.85421437361;38279.61720382872;38630.42054369243;31916.202094946882;32001;32586.837065814518;32917.341653166324;32926.50610240896;32365.676343236268;32554.674453255164;32827.17932051718;32917;33068.33863322672;32836.179095522806;33304.83347583246;33461.83269083639;33585;33654.495182571794;27924.441511169258;29337.266568335963;29548;29595.049504950493;29799;23425.531489370456;23789.405264868517;24010.51978960446;24056.15803446871;24124.27627171188 02:52:16 INFO - 2015-12-20 02:52:16,790 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.1051015117067;315.6874694052888;316.7054639185557;325.12217014062026;327.7361723812332;12608.432620532076;12985.80521292179;15157.621059473518;15504.534863954072;15904.920475397636;15938.52184434466;16237.594060148502;16463.094529800856;16473.176341182952;16483;4810.350602668647;5024.698518088908;5028.2709007193935;5039.19372900336;5041.52105549974;4964.156093464102;4992.151334273164;5111.84664460065;5134.563562097226;5145.485451454862;5020.0963826511215;5101.260317253996;5125.871853203681;5130.692158470485;5328;5284.788608455658;5288.338957630296;5291.232771248186;5307.814226502092;5310.362756469229;4838.322634831126;5085.567726743231;5099.796008159669;5108.974455127738;5123.692578445268;11547.422628868608;11689.298642081503;11693;11719.824202636968;11816.409179540988;1763.973540396895;1781.536800431884;1857.4149143019906;1885.5097674604701;1932.294712429967;8350.33197344211;8449.662013519452;8454.746357609281;8483.787905302417;8713.912860871373;1721.7494557688526;1736.9826301736948;1749.2215963896072;1769.8849574777598;1809.782826060868;54159.458405416226;54931.725341373436;55510.16734748982;58280.70859645717;59079.40920590782;9604.183644390305;9816.65641702537;9882.4564648945;9922.702318930444;9939.701808945743;12728.1726687765;12765.617031488884;12768.61694149177;12786.680332991564;12794.616161515169;7016.92983070173;7344.522606030698;7368.37368823656;7373.520721153108;7393.260673932564;7070.222275549685;7121.181064177686;7133.108361454818;7151.821204469826;7177.3899218567;4139.523954745183;4226.5139508956245;4227.7463352198965;4257.446531950888;7472;3071.738902193294;3140.952885706716;3145.191514878954;3196.38582515828;3201.695838895301;364.4078372644453;368.382958544437;415.488948593226;822.6791551294999;876.8334016536837;9392.248620110375;9497.810043799085;9632.566534505964;9814.165795907427;9949;390.64451349272025;395.539196835689;396.49644950912756;398.040721860321;414.65583565640446;5290.9736348769675;5356.116240820299;5382.892342153135;5389.245505629215;5426.050441172858;483935;488771;492116;503217;509072;71911.64044179746;73160.63419682973;73685.6315718418;74277;74909.62545187239;436.38687643860425;439.8570464599018;441.46141707117266;442.07826681369704;443.1668463288996;9355.766105847137;9430.292728045286;9558.187554057982;9568.330216884751;9614.134727874525;30555;31138.37723245477;31428.84285578649;31528;31853;44352.55647443613;45045.32432013457;45839.31241031454;45939;51500.227496586835;8079.111297757125;8269.793255168428;8366;8384.622691978997;8406.117357677356;15418.383264669736;15927.283272253007;15945.760813587573;15998.120103394425;16406;13641.931790340985;13706.657333566342;13935.721285574435;14052.367643456273;14102.224377659328;12915.806262905877;13085.67285817824;13446.260455675032;13822.10156339875;13907.096038757853;8619.956900215459;8927.375083744335;13705.657358566115;13976.510822121178;14186.503472378417;13163.47346106145;13548.119372240773;13708.040437169302;13813.447462101403;14031.087979281314;13166;14793.038452500554;14992.2503874808;15238.466653667068;15536.223188840739 02:52:16 INFO - 2015-12-20 02:52:16,791 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1430.5922811998582;1640.5652502086948;1691.7208660571007;1710.4099085815396;1719.5872990482285;5988.191594134791;6257.687115644222;6902.4478041756665;7450.292222238885;7463.402927765773;6980.546264492805;7077.964610176942;7164.4626653001105;7183.784486465414;7224.7471338503165;2051.159024799829;2070.896455177243;2076.4705000225;2088.8224500917363;2092.5082605587677;2081.4484161697164;2100.747910250772;2121.9257325993594;2156.91372345106;2165.8050775430206;2048.1193086972594;2065.0500769645982;2078.0752565108533;2078.688196770489;2083.104265165978;2080.5942841145907;2112.0812446585633;2112.7042214090116;2114.598226336999;2117.851750377474;2096.444442222812;2113.545587698652;2120.4380839077658;2122.586095711337;2126.766055733868;7296.087989001375;7365.852682946311;7383.114026316823;7383.889241661379;7387.963060184718;4262;4320.567943205686;4322.783860806947;4322.913541729148;4322.978385108086;2690.7174746651517;2702;2810.9578356324673;2837.560178172366;2843.431313737261;837.2422957223662;866.5580553917484;882.3691060891493;887.5739644970386;900.4237288135533;9721.513924303756;9768.413895166384;9837.80324393508;9847.458389788559;9852.064053914866;3888.844446222176;3898.317794385971;3954.9604503955165;4002.779847108437;4023.75857448554;8487.151284871587;8492.235698787015;8503.532305723122;8504.107068757816;8519.020312664123;4389.802458889294;4395.956040439619;4402.25161722508;4402.713823601455;4411.867643970686;3242.854071566785;3274.590676165479;3761.5298087739034;3985.960140398559;4014.41790940312;3403.2342722887647;3436.9656303437146;3443.8450269737923;3477.4783782432837;3491.6159222485508;1108.2685427617735;1125.1224045244721;1137.4938152522047;1144.227646338718;1163.906887449002;948.8197242523898;961.5721004153224;986;992.4194346307347;999.5901680311038;6870;6875.724971001204;6879.484038697117;6890.10428644273;6917.169939607279;408.8058172368101;410.89316777638027;413.3881854854832;424.312613566025;426.6032589691617;5211.114110601131;5259.316288882421;5279.260903473517;5279.260903473517;5279.498447647467;8450.112738162527;8549.743507694779;8806.735797926072;8821.69124080667;8910.86633700495;8611.913880861237;8648.913510864937;8666.133386661284;8762.86855697165;8778.253848422828;6802.693878775467;6877.3810357068105;6957;6975.128108986478;6989.790306290819;6556.541042127196;6571.638559879252;6575.572587781779;6594.538382313192;6596.70314835824;7623.809404764926;7633.1985141559335;7861.921380786119;7886.369090472863;7906.407019473448;7805.868149118232;8047.919520804951;8107.675692972215;8121.959390203011;8152.633131509215;5269.552088072557;5514.751836167462;6278.277998030285;6515.511336649865;6517.348265173445;6962.7214911405;6966.721331146698;6971.337722916518;7007.929920700932;7009.12385951756;6320.873582528416;6457.4511166551365;6506.308359826385;6590.7693230736695;6633.834154145992;6417.133686952202;6439.130717353098;6466.935330646634;6510.381513756186;6531.052997315458;6502.60984340941;6530.444912182517;6530.6081635100145;6533.150690410406;6539.182602174728;5800.042992906292;5805.10020946754;5812.389699081536;5969.850753731192;5978.163057171912;6051.001584738468;6070.484008859296;6071.3625069368845;6073.5748497604745;6073.726682299219 02:52:16 INFO - 2015-12-20 02:52:16,794 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.44623430544743;292.56700083875864;297.15755832215666;297.2716843732855;297.96275465566805;5556.16657501375;5600.495955364022;5629.60592758507;5634.239377684022;5654.293213348332;5524.33707955045;5533.142362933751;5534.584906132046;5537;5553.416891226424;4297;4305.246581848171;4305.332673435622;4307.590778876001;4308.9784551077355;4037.9703175690156;4129;4170.936411215151;4306.332518459628;4315.676324275676;4250.213710463574;4258.127083947783;4270.12462445198;4274.187904298189;4277.957220427787;4249;4270.231358355495;4271.97864010681;4277.657787377034;4287.721298115644;3720.8325625346924;3740.2893450244364;3741.064733816546;3749.137698329372;3763.9247215055548;5273.789048438058;5422.349318081855;5438.564914806806;5448.237246785414;5468.0977638689565;4863.586595139417;4865.756712164378;4870;4878.463369029404;4880.389951256093;5865.970670146665;5896.734646940855;5902.996490596609;5907.172995780594;5908.556858235649;3970.960290397088;3973.046468847485;3974.880753577397;3979.7612143271494;3981.880543583697;5920.674362910038;6080.9391906081255;6149.631022138686;6181.289151747562;6196.039613859859;4027.9798601006805;4069.4506241656995;4070.226656935232;4088.836446542105;4089.91820163601;4124.752514849119;4140.254754144223;4145.7719825409895;4150.27370210212;4152.709310348247;4808.495108013678;4810.759462026885;4812.831550895772;4819.518048195152;4830.9275360869615;5710.400407957188;5839.357670656224;5845.561582881301;5847;5849.532037436995;1438.3958737330138;1457.0893191755154;1461.0211158523814;1461.6053665510465;1462.795208670787;944.8015916657579;947.8436058050482;962.2782912815388;966.9274804389559;974.4153507895348;5113.718745469035;5120.1039818031695;5124.180131178993;5131.512506311894;5136.101182293084;5872.677002764804;6014.51883849291;6071.453569178795;6106.145139680449;6124.663143527148;5144.074066668036;5148.742562871841;5153.871153221199;5173.1722924331925;5180.533751962342;3289.8190599517256;3302.488114342281;3316.4196265653413;3319.2033911861463;3328.9680199138343;5639.915401268984;5744.971275143597;5754.856128596819;5758.62568933018;5759.827205183851;6270.2475702915945;6311.368863113744;6323.20959880015;6325.987841945267;6332.905006424908;5730.398308177581;5735.541156707453;5752.511036561856;5755.7409916553015;5775.595708300379;6180.629162250099;6184.752609895734;6191.318954914866;6192.81421557354;6202.255729312331;5887.499562537232;5983.311919129182;5996.220491336098;6000.0999850022845;6002.189704389852;5767.163761254678;5772.39389864075;5773.364929857797;5778.191053252632;5791.189233507228;4066.9389959151226;4067.2678917795083;4069.1861627673993;4073.45008423859;4077.8164982575263;5990.041593345044;6133.141360209664;6154.507639388928;6158;6166.414190651881;5900.734466948912;5916.053431450947;5919.4968427684125;5921.259842519685;5936.406359364029;5911.172435859069;5915.822525324247;5921.733521991435;5924.851878703067;5930.881382372242;5689.431056894443;5725.484706376446;5790.710464476675;5804.94195058044;5808.070708686759;5979.192808970907;5983.311919129356;5983.880322393615;5983.910241346296;5993;5834.504067154339;5842.737076831468;5844.3571207168025;5844.415558444121;5845.766169353348 02:52:16 INFO - 2015-12-20 02:52:16,794 DEBUG : BROWSER_OUTPUT: |5;yui.html;633.3508154142003;641.3298103481861;700.9345794392523;785.520832292302;821.7411515372661;10487.790244195121;10532.894671053287;10574.312669676465;10617.469126543661;10619.893801061988;10967.287126336783;11713.941430292858;11722.23805452645;11778.528858845657;11794.29234245946;630.6941133550224;637.2926052082186;780.7423550228425;788.4402074527093;805.3758337288618;783.7217787685375;789.8854666073416;791.5329955326356;793.5556088590379;797.3023604346197;825.0553116681397;827.2265431821236;827.9461834980707;828.6064119543199;834.8330333933208;812.6058861452191;813.8128230506987;813.9552324622143;817.6851912013888;818.6397984886631;604.6402390577599;605.5821483176638;607.3501353551701;609.3053918532831;610.2402508876477;10925.399103049329;11062.834057489064;11077.889221107847;11082.833757493645;11088.722781930435;10618.203634727426;10700.464976751131;11084.445777711082;11232.157588180919;11413.258138220988;9189.310801689833;9314.115159059946;9481.620735170585;9487.573059212353;9545.90454095457;3034.893778717734;3077.338372249955;3108.456020196479;3123.120735155965;3124.297033167542;38321.42517862206;38393.232135357415;38595.8421247363;38757.41863872044;38841.417378739345;9064.410813297114;9083.863742043875;9306.581203845843;9358.672446464341;9386.249100071978;16466.75299870503;16495.91752041232;16505.33978640841;16507.504774856774;16511.669766604842;6335.936640633627;6339.175907132043;6421.325760795049;6476.287608363076;6506.479481641457;3653.8173091345325;3658.158623516553;3688.3360995020616;3693.279810436939;3726.2174943261675;2557.0794513974956;2583.134649892307;2595.480903819206;2601.8308809927294;2602.9349266268496;443.45898004434537;464.90934267818125;468.4168210577852;471.07433892401593;475.89768199837204;528.3422139436426;528.7594144664246;548.5748544877752;587.136908744154;589.0869152813123;7176.856462870714;7696.307332340116;8194.623559167774;8458.703945361884;8723.127687231226;561.6854561445604;613.2303958532013;617.8455386153462;624.6345887655682;626.7023163997065;3478.1652403423504;3533.611302756695;3619.8190090495896;3723.6834869036434;3826.081740382344;49281.507184927694;49362.75318623456;49850.25224621633;50034.49965500371;50230;43063.784681076395;43309.56690433119;43485.78257108758;43996.780016099714;44116.55883441125;40480.1903961925;41131;41282.793586031876;41303.586964130576;41757.37363939543;7487.6630551626395;7712.035995500562;7742.341900938258;8010.078840933134;8036.758897233092;30073.398532029674;30534.236644084074;30583.847080764455;31256.687433126288;31422.842885785423;36925.446118308784;40208.79373618796;40550.79724601358;40570.79714601408;40642.79678601588;9859.605615775288;9885.95057024739;9945.204383649436;9955.153811925778;10270;10982.450877456255;11385.829212561985;11630.185886987829;11863.228890122115;12067.81898271509;9985.550650220903;10144.543495542866;10184.847227291744;10344.844827327746;10824.24230303871;9614.278929080487;9614.90385096168;9723.416595004323;9767.755806104904;9898.950505247716;9353.345265831327;9363.906360936304;9508.572114254737;9685.32202745801;9743.512824358611;8949.955250223707;9037.593308301273;9165.587548560197;9253.67612133572;9478.763030924281;8531.189536993976;8908.153725396078;8988.146126118008;9026.277897768294;9080.318976076689 02:52:16 INFO - 2015-12-20 02:52:16,794 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:52:16 INFO - 2015-12-20 02:52:16,794 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:52:16 INFO - 2015-12-20 02:52:16,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,321 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608736783__endTimestamp 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4751.58 Median:4907.63 stddev:497.90 (10.1%) stddev-sans-first:472.76 02:52:16 INFO - 2015-12-20 02:52:16,795 DEBUG : BROWSER_OUTPUT: Values: 2702.1 2748.3 2763.8 2786.5 2788.1 4659.6 4897.0 4925.6 4937.6 4967.2 4698.6 4719.7 4754.2 4852.3 4883.3 4432.4 4495.4 4542.6 4579.5 4617.7 4373.7 4444.7 4526.9 4550.5 4583.2 4256.0 4354.7 4362.9 4448.0 4522.6 4339.5 4359.3 4414.9 4420.9 4434.6 4368.3 4369.0 4379.6 4416.3 4421.4 4520.2 4623.4 4630.0 4646.8 4670.6 4991.8 4998.8 5023.0 5028.8 5050.7 5137.2 5146.0 5173.7 5224.9 5236.8 4843.5 4862.5 4862.6 4863.1 4888.1 5050.9 5150.6 5265.5 5346.5 5348.1 5068.3 5070.6 5070.8 5101.6 5227.0 5137.2 5140.0 5152.6 5167.9 5192.4 4802.5 4975.8 5047.9 5102.4 5169.5 5126.9 5136.9 5144.8 5145.9 5158.7 4288.8 4290.1 4294.2 4329.5 4341.6 3605.3 3708.1 3714.3 3767.3 3811.8 4434.8 4435.9 4462.9 4491.1 4508.7 4921.9 5189.3 5192.4 5202.1 5202.2 4378.2 4392.1 4395.1 4400.1 4437.2 4562.1 4618.2 4627.6 4655.0 4697.9 4907.2 4907.6 4940.9 4949.9 5013.7 4905.2 5029.2 5254.9 5289.0 5381.4 4885.8 4965.7 4973.0 4974.3 5010.0 4789.3 5161.5 5187.7 5191.3 5195.5 4986.1 5082.9 5138.2 5163.0 5203.1 4992.7 5030.2 5032.6 5041.0 5069.8 4768.9 4932.6 5006.5 5023.7 5033.6 4865.8 4877.4 4898.5 4950.5 4985.1 5033.2 5062.3 5071.1 5081.5 5091.0 4674.1 4934.9 4944.6 4957.1 4987.3 02:52:16 INFO - 2015-12-20 02:52:16,796 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,796 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41619.56 Median:183128.42 stddev:68294.56 (37.3%) stddev-sans-first:68416.58 02:52:16 INFO - 2015-12-20 02:52:16,797 DEBUG : BROWSER_OUTPUT: Values: 564.8 573.3 577.5 578.1 584.1 34621.3 35222.1 35260.6 35287.0 35321.8 39344.4 39823.6 39832.4 39853.8 40003.0 7938.8 8078.9 8102.5 8117.9 8126.1 7867.1 7921.4 7987.2 8017.5 8022.8 7911.1 7959.0 7983.9 8015.6 8021.9 7719.8 7763.7 7771.5 7797.3 7801.6 7901.8 8017.0 8046.9 8057.8 8064.2 35834.3 36449.8 36567.3 36582.1 36712.0 2422.6 2936.4 2970.8 3100.5 3143.4 26395.6 30213.4 31315.7 31372.8 32737.7 3135.1 3140.7 3152.7 3165.3 3183.5 176791.1 177649.0 178056.0 178630.0 178632.0 49094.0 49112.0 49209.0 50304.7 51756.0 63154.0 64304.0 64419.4 64499.8 64578.0 13005.2 13184.0 13271.9 13307.4 13317.6 10793.3 10906.1 10937.5 10963.0 10988.1 18089.5 18404.4 18415.9 18453.4 18464.4 6871.4 7074.6 7133.6 7140.6 7261.2 821.3 839.3 943.8 1023.8 1032.3 24339.8 24477.8 24558.4 24594.4 24612.3 926.6 947.5 1076.2 1090.7 1111.2 12909.2 13074.8 13092.9 13254.5 13424.5 322982.0 328890.0 331584.0 331743.0 332952.0 46598.3 47083.5 47306.0 47338.5 47516.8 1200.7 1211.6 1223.7 1234.9 1241.8 23833.9 23845.3 29383.6 29966.4 30401.4 43630.3 44213.3 44327.6 44373.3 44381.6 247791.0 250459.0 252143.0 252156.0 252267.0 38405.0 38528.0 38758.2 38773.6 38997.2 35782.6 38044.2 38192.9 38279.6 38630.4 31916.2 32001.0 32586.8 32917.3 32926.5 32365.7 32554.7 32827.2 32917.0 33068.3 32836.2 33304.8 33461.8 33585.0 33654.5 27924.4 29337.3 29548.0 29595.0 29799.0 23425.5 23789.4 24010.5 24056.2 24124.3 02:52:16 INFO - 2015-12-20 02:52:16,797 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,797 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26291.02 Median:44698.94 stddev:81034.20 (181.3%) stddev-sans-first:81238.05 02:52:16 INFO - 2015-12-20 02:52:16,797 DEBUG : BROWSER_OUTPUT: Values: 315.1 315.7 316.7 325.1 327.7 12608.4 12985.8 15157.6 15504.5 15904.9 15938.5 16237.6 16463.1 16473.2 16483.0 4810.4 5024.7 5028.3 5039.2 5041.5 4964.2 4992.2 5111.8 5134.6 5145.5 5020.1 5101.3 5125.9 5130.7 5328.0 5284.8 5288.3 5291.2 5307.8 5310.4 4838.3 5085.6 5099.8 5109.0 5123.7 11547.4 11689.3 11693.0 11719.8 11816.4 1764.0 1781.5 1857.4 1885.5 1932.3 8350.3 8449.7 8454.7 8483.8 8713.9 1721.7 1737.0 1749.2 1769.9 1809.8 54159.5 54931.7 55510.2 58280.7 59079.4 9604.2 9816.7 9882.5 9922.7 9939.7 12728.2 12765.6 12768.6 12786.7 12794.6 7016.9 7344.5 7368.4 7373.5 7393.3 7070.2 7121.2 7133.1 7151.8 7177.4 4139.5 4226.5 4227.7 4257.4 7472.0 3071.7 3141.0 3145.2 3196.4 3201.7 364.4 368.4 415.5 822.7 876.8 9392.2 9497.8 9632.6 9814.2 9949.0 390.6 395.5 396.5 398.0 414.7 5291.0 5356.1 5382.9 5389.2 5426.1 483935.0 488771.0 492116.0 503217.0 509072.0 71911.6 73160.6 73685.6 74277.0 74909.6 436.4 439.9 441.5 442.1 443.2 9355.8 9430.3 9558.2 9568.3 9614.1 30555.0 31138.4 31428.8 31528.0 31853.0 44352.6 45045.3 45839.3 45939.0 51500.2 8079.1 8269.8 8366.0 8384.6 8406.1 15418.4 15927.3 15945.8 15998.1 16406.0 13641.9 13706.7 13935.7 14052.4 14102.2 12915.8 13085.7 13446.3 13822.1 13907.1 8620.0 8927.4 13705.7 13976.5 14186.5 13163.5 13548.1 13708.0 13813.4 14031.1 13166.0 14793.0 14992.3 15238.5 15536.2 02:52:16 INFO - 2015-12-20 02:52:16,797 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5028.34 Median:6369.00 stddev:2648.11 (41.6%) stddev-sans-first:2641.74 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: Values: 1430.6 1640.6 1691.7 1710.4 1719.6 5988.2 6257.7 6902.4 7450.3 7463.4 6980.5 7078.0 7164.5 7183.8 7224.7 2051.2 2070.9 2076.5 2088.8 2092.5 2081.4 2100.7 2121.9 2156.9 2165.8 2048.1 2065.1 2078.1 2078.7 2083.1 2080.6 2112.1 2112.7 2114.6 2117.9 2096.4 2113.5 2120.4 2122.6 2126.8 7296.1 7365.9 7383.1 7383.9 7388.0 4262.0 4320.6 4322.8 4322.9 4323.0 2690.7 2702.0 2811.0 2837.6 2843.4 837.2 866.6 882.4 887.6 900.4 9721.5 9768.4 9837.8 9847.5 9852.1 3888.8 3898.3 3955.0 4002.8 4023.8 8487.2 8492.2 8503.5 8504.1 8519.0 4389.8 4396.0 4402.3 4402.7 4411.9 3242.9 3274.6 3761.5 3986.0 4014.4 3403.2 3437.0 3443.8 3477.5 3491.6 1108.3 1125.1 1137.5 1144.2 1163.9 948.8 961.6 986.0 992.4 999.6 6870.0 6875.7 6879.5 6890.1 6917.2 408.8 410.9 413.4 424.3 426.6 5211.1 5259.3 5279.3 5279.3 5279.5 8450.1 8549.7 8806.7 8821.7 8910.9 8611.9 8648.9 8666.1 8762.9 8778.3 6802.7 6877.4 6957.0 6975.1 6989.8 6556.5 6571.6 6575.6 6594.5 6596.7 7623.8 7633.2 7861.9 7886.4 7906.4 7805.9 8047.9 8107.7 8122.0 8152.6 5269.6 5514.8 6278.3 6515.5 6517.3 6962.7 6966.7 6971.3 7007.9 7009.1 6320.9 6457.5 6506.3 6590.8 6633.8 6417.1 6439.1 6466.9 6510.4 6531.1 6502.6 6530.4 6530.6 6533.2 6539.2 5800.0 5805.1 5812.4 5969.9 5978.2 6051.0 6070.5 6071.4 6073.6 6073.7 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4853.79 Median:5578.33 stddev:1458.58 (26.1%) stddev-sans-first:1421.79 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: Values: 285.4 292.6 297.2 297.3 298.0 5556.2 5600.5 5629.6 5634.2 5654.3 5524.3 5533.1 5534.6 5537.0 5553.4 4297.0 4305.2 4305.3 4307.6 4309.0 4038.0 4129.0 4170.9 4306.3 4315.7 4250.2 4258.1 4270.1 4274.2 4278.0 4249.0 4270.2 4272.0 4277.7 4287.7 3720.8 3740.3 3741.1 3749.1 3763.9 5273.8 5422.3 5438.6 5448.2 5468.1 4863.6 4865.8 4870.0 4878.5 4880.4 5866.0 5896.7 5903.0 5907.2 5908.6 3971.0 3973.0 3974.9 3979.8 3981.9 5920.7 6080.9 6149.6 6181.3 6196.0 4028.0 4069.5 4070.2 4088.8 4089.9 4124.8 4140.3 4145.8 4150.3 4152.7 4808.5 4810.8 4812.8 4819.5 4830.9 5710.4 5839.4 5845.6 5847.0 5849.5 1438.4 1457.1 1461.0 1461.6 1462.8 944.8 947.8 962.3 966.9 974.4 5113.7 5120.1 5124.2 5131.5 5136.1 5872.7 6014.5 6071.5 6106.1 6124.7 5144.1 5148.7 5153.9 5173.2 5180.5 3289.8 3302.5 3316.4 3319.2 3329.0 5639.9 5745.0 5754.9 5758.6 5759.8 6270.2 6311.4 6323.2 6326.0 6332.9 5730.4 5735.5 5752.5 5755.7 5775.6 6180.6 6184.8 6191.3 6192.8 6202.3 5887.5 5983.3 5996.2 6000.1 6002.2 5767.2 5772.4 5773.4 5778.2 5791.2 4066.9 4067.3 4069.2 4073.5 4077.8 5990.0 6133.1 6154.5 6158.0 6166.4 5900.7 5916.1 5919.5 5921.3 5936.4 5911.2 5915.8 5921.7 5924.9 5930.9 5689.4 5725.5 5790.7 5804.9 5808.1 5979.2 5983.3 5983.9 5983.9 5993.0 5834.5 5842.7 5844.4 5844.4 5845.8 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: 02:52:16 INFO - 2015-12-20 02:52:16,798 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12045.03 Median:528.55 stddev:13690.10 (2590.1%) stddev-sans-first:13701.68 02:52:16 INFO - 2015-12-20 02:52:16,800 DEBUG : BROWSER_OUTPUT: Values: 633.4 641.3 700.9 785.5 821.7 10487.8 10532.9 10574.3 10617.5 10619.9 10967.3 11713.9 11722.2 11778.5 11794.3 630.7 637.3 780.7 788.4 805.4 783.7 789.9 791.5 793.6 797.3 825.1 827.2 827.9 828.6 834.8 812.6 813.8 814.0 817.7 818.6 604.6 605.6 607.4 609.3 610.2 10925.4 11062.8 11077.9 11082.8 11088.7 10618.2 10700.5 11084.4 11232.2 11413.3 9189.3 9314.1 9481.6 9487.6 9545.9 3034.9 3077.3 3108.5 3123.1 3124.3 38321.4 38393.2 38595.8 38757.4 38841.4 9064.4 9083.9 9306.6 9358.7 9386.2 16466.8 16495.9 16505.3 16507.5 16511.7 6335.9 6339.2 6421.3 6476.3 6506.5 3653.8 3658.2 3688.3 3693.3 3726.2 2557.1 2583.1 2595.5 2601.8 2602.9 443.5 464.9 468.4 471.1 475.9 528.3 528.8 548.6 587.1 589.1 7176.9 7696.3 8194.6 8458.7 8723.1 561.7 613.2 617.8 624.6 626.7 3478.2 3533.6 3619.8 3723.7 3826.1 49281.5 49362.8 49850.3 50034.5 50230.0 43063.8 43309.6 43485.8 43996.8 44116.6 40480.2 41131.0 41282.8 41303.6 41757.4 7487.7 7712.0 7742.3 8010.1 8036.8 30073.4 30534.2 30583.8 31256.7 31422.8 36925.4 40208.8 40550.8 40570.8 40642.8 9859.6 9886.0 9945.2 9955.2 10270.0 10982.5 11385.8 11630.2 11863.2 12067.8 9985.6 10144.5 10184.8 10344.8 10824.2 9614.3 9614.9 9723.4 9767.8 9899.0 9353.3 9363.9 9508.6 9685.3 9743.5 8950.0 9037.6 9165.6 9253.7 9478.8 8531.2 8908.2 8988.1 9026.3 9080.3 02:52:16 INFO - 2015-12-20 02:52:16,800 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:52:16 INFO - 2015-12-20 02:52:16,800 DEBUG : BROWSER_OUTPUT: 02:52:17 INFO - 2015-12-20 02:52:17,565 INFO : Browser exited with error code: 0 02:52:17 INFO - 2015-12-20 02:52:17,582 INFO : Completed test dromaeo_css (00:18:35) 02:52:17 INFO - 2015-12-20 02:52:17,582 INFO : Starting test kraken 02:52:17 INFO - 2015-12-20 02:52:17,582 DEBUG : operating with platform_type : linux_ 02:52:17 INFO - 2015-12-20 02:52:17,582 INFO : Initialising browser for kraken test... 02:52:17 INFO - 2015-12-20 02:52:17,588 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzScEQA/profile http://localhost:51957/getInfo.html 02:52:21 INFO - 2015-12-20 02:52:21,638 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:52:22 INFO - 2015-12-20 02:52:22,485 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:52:22 INFO - 2015-12-20 02:52:22,485 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:52:22 INFO - 2015-12-20 02:52:22,486 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:52:22 INFO - 2015-12-20 02:52:22,486 DEBUG : BROWSER_OUTPUT: __metrics 02:52:22 INFO - 2015-12-20 02:52:22,602 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:52:23 INFO - 2015-12-20 02:52:23,525 INFO : Browser initialized. 02:52:23 INFO - 2015-12-20 02:52:23,526 INFO : Running cycle 1/1 for kraken test... 02:52:23 INFO - 2015-12-20 02:52:23,526 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzScEQA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:52:35 INFO - 2015-12-20 02:52:35,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 150790144 02:52:35 INFO - 2015-12-20 02:52:35,512 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-12-20 02:52:38,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51957/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:38 INFO - 2015-12-20 02:52:38,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 151650304 02:52:38 INFO - 2015-12-20 02:52:38,713 DEBUG : BROWSER_OUTPUT: 02:52:41 INFO - 2015-12-20 02:52:41,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51957/tests/kraken/driver.html?testName=audio-dft) 02:52:42 INFO - 2015-12-20 02:52:42,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 151404544 02:52:42 INFO - 2015-12-20 02:52:42,041 DEBUG : BROWSER_OUTPUT: 02:52:44 INFO - 2015-12-20 02:52:44,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51957/tests/kraken/driver.html?testName=audio-fft) 02:52:45 INFO - 2015-12-20 02:52:45,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 145436672 02:52:45 INFO - 2015-12-20 02:52:45,536 DEBUG : BROWSER_OUTPUT: 02:52:47 INFO - 2015-12-20 02:52:47,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51957/tests/kraken/driver.html?testName=audio-oscillator) 02:52:48 INFO - 2015-12-20 02:52:48,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 146714624 02:52:48 INFO - 2015-12-20 02:52:48,219 DEBUG : BROWSER_OUTPUT: 02:52:50 INFO - 2015-12-20 02:52:50,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:51 INFO - 2015-12-20 02:52:51,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 146116608 02:52:51 INFO - 2015-12-20 02:52:51,079 DEBUG : BROWSER_OUTPUT: 02:52:54 INFO - 2015-12-20 02:52:54,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51957/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:54 INFO - 2015-12-20 02:52:54,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 147456000 02:52:54 INFO - 2015-12-20 02:52:54,727 DEBUG : BROWSER_OUTPUT: 02:52:58 INFO - 2015-12-20 02:52:58,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51957/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:58 INFO - 2015-12-20 02:52:58,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 146505728 02:52:58 INFO - 2015-12-20 02:52:58,819 DEBUG : BROWSER_OUTPUT: 02:53:01 INFO - 2015-12-20 02:53:01,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51957/tests/kraken/driver.html?testName=json-parse-financial) 02:53:02 INFO - 2015-12-20 02:53:02,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 146857984 02:53:02 INFO - 2015-12-20 02:53:02,285 DEBUG : BROWSER_OUTPUT: 02:53:04 INFO - 2015-12-20 02:53:04,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:04 INFO - 2015-12-20 02:53:04,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 148271104 02:53:04 INFO - 2015-12-20 02:53:04,639 DEBUG : BROWSER_OUTPUT: 02:53:06 INFO - 2015-12-20 02:53:06,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:07 INFO - 2015-12-20 02:53:07,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 147427328 02:53:07 INFO - 2015-12-20 02:53:07,142 DEBUG : BROWSER_OUTPUT: 02:53:09 INFO - 2015-12-20 02:53:09,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:09 INFO - 2015-12-20 02:53:09,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 147238912 02:53:09 INFO - 2015-12-20 02:53:09,885 DEBUG : BROWSER_OUTPUT: 02:53:12 INFO - 2015-12-20 02:53:12,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:13 INFO - 2015-12-20 02:53:13,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 148254720 02:53:13 INFO - 2015-12-20 02:53:13,064 DEBUG : BROWSER_OUTPUT: 02:53:15 INFO - 2015-12-20 02:53:15,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:16 INFO - 2015-12-20 02:53:16,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 147951616 02:53:16 INFO - 2015-12-20 02:53:16,218 DEBUG : BROWSER_OUTPUT: 02:53:17 INFO - 2015-12-20 02:53:17,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51957/tests/kraken/driver.html?testName=ai-astar) 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 148582400 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;110;112;114;115;123;121;111;113;113 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;150;164;139;155;155;137;163;130 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;163;162;162;182;164;166;161 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;71;76;136;73;78;74;74;88 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;136;95;100;94;141;95;95;133 02:53:18 INFO - 2015-12-20 02:53:18,246 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;109;110;110;110;111 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;149;148;148;147;147;148;148;149 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;97;96;96;97;97;96;95 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;79;74;76;75;77;85;73;72 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;70;68;68;69;67;68;68;68 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;93;86;84;84;83;88;85;84 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;128;120;128;135;141;123;122;126;120 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;143;149;146;146;140;146;146;139;135 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;70;69;72;69;70;70;69;68 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,768 02:53:18 INFO - 2015-12-20 02:53:18,247 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608798240__endTimestamp 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.50 Median:113.50 stddev:4.22 (3.7%) stddev-sans-first:4.44 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 112.0 114.0 115.0 123.0 121.0 111.0 113.0 113.0 02:53:18 INFO - 2015-12-20 02:53:18,248 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:154.50 stddev:12.48 (8.1%) stddev-sans-first:13.04 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 150.0 164.0 139.0 155.0 155.0 137.0 163.0 130.0 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.70 Median:163.00 stddev:6.24 (3.8%) stddev-sans-first:6.54 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 163.0 162.0 162.0 182.0 164.0 166.0 161.0 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:19.62 (26.3%) stddev-sans-first:20.55 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 71.0 76.0 136.0 73.0 78.0 74.0 74.0 88.0 02:53:18 INFO - 2015-12-20 02:53:18,249 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:20.16 (21.4%) stddev-sans-first:20.76 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 136.0 95.0 100.0 94.0 141.0 95.0 95.0 133.0 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 109.0 110.0 110.0 110.0 111.0 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 149.0 148.0 148.0 147.0 147.0 148.0 148.0 149.0 02:53:18 INFO - 2015-12-20 02:53:18,250 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,251 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 97.0 96.0 96.0 97.0 97.0 96.0 95.0 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.10 Median:75.50 stddev:3.70 (4.9%) stddev-sans-first:3.90 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 79.0 74.0 76.0 75.0 77.0 85.0 73.0 72.0 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 70.0 68.0 68.0 69.0 67.0 68.0 68.0 68.0 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:3.12 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 93.0 86.0 84.0 84.0 83.0 88.0 85.0 84.0 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.00 stddev:6.71 (5.3%) stddev-sans-first:7.09 02:53:18 INFO - 2015-12-20 02:53:18,252 DEBUG : BROWSER_OUTPUT: Values: 125.0 128.0 120.0 128.0 135.0 141.0 123.0 122.0 126.0 120.0 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:146.00 stddev:4.97 (3.4%) stddev-sans-first:4.47 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: Values: 135.0 143.0 149.0 146.0 146.0 140.0 146.0 146.0 139.0 135.0 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.33 (1.9%) stddev-sans-first:1.36 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 69.0 72.0 69.0 70.0 70.0 69.0 68.0 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:18 INFO - 2015-12-20 02:53:18,253 DEBUG : BROWSER_OUTPUT: 02:53:19 INFO - 2015-12-20 02:53:19,153 INFO : Browser exited with error code: 0 02:53:19 INFO - 2015-12-20 02:53:19,208 INFO : Completed test kraken (00:01:01) 02:53:19 INFO - 2015-12-20 02:53:19,209 INFO : Starting test v8_7 02:53:19 INFO - 2015-12-20 02:53:19,209 DEBUG : operating with platform_type : linux_ 02:53:19 INFO - 2015-12-20 02:53:19,209 INFO : Initialising browser for v8_7 test... 02:53:19 INFO - 2015-12-20 02:53:19,215 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBNBHP/profile http://localhost:51957/getInfo.html 02:53:23 INFO - 2015-12-20 02:53:23,385 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:53:24 INFO - 2015-12-20 02:53:24,219 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:53:24 INFO - 2015-12-20 02:53:24,219 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:53:24 INFO - 2015-12-20 02:53:24,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:53:24 INFO - 2015-12-20 02:53:24,220 DEBUG : BROWSER_OUTPUT: __metrics 02:53:24 INFO - 2015-12-20 02:53:24,364 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:53:25 INFO - 2015-12-20 02:53:25,301 INFO : Browser initialized. 02:53:25 INFO - 2015-12-20 02:53:25,302 INFO : Running cycle 1/1 for v8_7 test... 02:53:25 INFO - 2015-12-20 02:53:25,302 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBNBHP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:37 INFO - 2015-12-20 02:53:37,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 150597632 02:53:37 INFO - 2015-12-20 02:53:37,309 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51957/tests/v8_7/run.html (next: http://localhost:51957/tests/v8_7/run.html) 02:53:58 INFO - 2015-12-20 02:53:58,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 145670144 02:53:58 INFO - 2015-12-20 02:53:58,935 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,935 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:58 INFO - 2015-12-20 02:53:58,935 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:58 INFO - 2015-12-20 02:53:58,935 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:58 INFO - 2015-12-20 02:53:58,936 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:58 INFO - 2015-12-20 02:53:58,936 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 02:53:58 INFO - 2015-12-20 02:53:58,936 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8649270913277 02:53:58 INFO - 2015-12-20 02:53:58,936 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1067.2358591248667 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |5;Earley;720.4610951008646 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |8;Splay;597.2797161442933 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 02:53:58 INFO - 2015-12-20 02:53:58,937 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608838933__endTimestamp 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: Values: 166.1 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.86 Median:191.86 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: Values: 191.9 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: Values: 280.7 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,938 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: Values: 5159.8 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: Values: 1067.2 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.46 Median:720.46 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: Values: 720.5 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: Values: 12144.6 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: Values: 26205.1 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,939 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.28 Median:597.28 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: Values: 597.3 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: Values: 4835.7 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:58 INFO - 2015-12-20 02:53:58,940 DEBUG : BROWSER_OUTPUT: 02:53:59 INFO - 2015-12-20 02:53:59,881 INFO : Browser exited with error code: 0 02:53:59 INFO - 2015-12-20 02:53:59,900 INFO : Completed test v8_7 (00:00:40) 02:53:59 INFO - 2015-12-20 02:53:59,960 INFO : Completed test suite (00:20:17) 02:53:59 INFO - 2015-12-20 02:53:59,961 DEBUG : Working with test: dromaeo_css 02:53:59 INFO - 2015-12-20 02:53:59,961 DEBUG : Generating results file: dromaeo_css 02:53:59 INFO - 2015-12-20 02:53:59,962 DEBUG : Working with test: kraken 02:53:59 INFO - 2015-12-20 02:53:59,962 DEBUG : Generating results file: kraken 02:53:59 INFO - 2015-12-20 02:53:59,962 INFO : javascript benchmark 02:53:59 INFO - 2015-12-20 02:53:59,962 DEBUG : Working with test: v8_7 02:53:59 INFO - 2015-12-20 02:53:59,962 DEBUG : Generating results file: v8_7 02:53:59 INFO - 2015-12-20 02:53:59,963 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:00 INFO - 2015-12-20 02:54:00,093 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 02:54:00 INFO - 2015-12-20 02:54:00,093 DEBUG : process_Request line: dromaeo_css 6274.55 graph.html#tests=[[72,132,43]] 02:54:00 INFO - 2015-12-20 02:54:00,093 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:00 INFO - 2015-12-20 02:54:00,121 DEBUG : process_Request line: kraken 1539.80 graph.html#tests=[[232,132,43]] 02:54:00 INFO - 2015-12-20 02:54:00,121 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:00 INFO - 2015-12-20 02:54:00,152 DEBUG : process_Request line: v8_7 21287.59 graph.html#tests=[[230,132,43]] 02:54:00 INFO - 2015-12-20 02:54:00,154 INFO : javascript benchmark 02:54:00 INFO - 2015-12-20 02:54:00,158 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2702.1488231207168, 2748.2579703480046, 2763.8341699498033, 2786.4566409550134, 2788.135677939839, 4659.557342052508, 4897.04507621014, 4925.5813255873245, 4937.604991600672, 4967.180415231487, 4698.577128058474, 4719.740414277213, 4754.191787396151, 4852.3206751054795, 4883.340748998884, 4432.423784907957, 4495.43807024122, 4542.636589072867, 4579.473360563527, 4617.676762626617, 4373.650107991369, 4444.666650001247, 4526.8868278292975, 4550.476695180047, 4583.220852455074, 4256.0, 4354.738715677069, 4362.8691139265875, 4447.955520444786, 4522.6155776759015, 4339.500957389909, 4359.324304732771, 4414.889627759299, 4420.911581768379, 4434.556544345572, 4368.301071828492, 4369.0, 4379.562043795627, 4416.315471101984, 4421.447319085114, 4520.208963431386, 4623.445186577598, 4630.027694184226, 4646.79089440976, 4670.556297151799, 4991.800327986876, 4998.750062496897, 5022.974885125587, 5028.7988480460735, 5050.696958182521, 5137.152369858969, 5146.0479811235045, 5173.663711858717, 5224.947750522484, 5236.764345604457, 4843.467218606021, 4862.51374862518, 4862.6353023523025, 4863.124637565272, 4888.095702295087, 5050.924236136461, 5150.639455238173, 5265.473452654781, 5346.5455436287575, 5348.090824559834, 5068.290439338495, 5070.61970352225, 5070.847874563769, 5101.566366858859, 5226.973865130726, 5137.152369858932, 5140.008432748873, 5152.562032227228, 5167.9224811627855, 5192.3769147702515, 4802.471728109905, 4975.800967961241, 5047.924281135786, 5102.36220472441, 5169.4572069932865, 5126.897462050738, 5136.922946155811, 5144.7942082316285, 5145.922811157836, 5158.716270605078, 4288.807003684841, 4290.077633308853, 4294.162638285567, 4329.480462344539, 4341.630961368256, 3605.3330133925306, 3708.054446116223, 3714.33142034431, 3767.2653832502397, 3811.7712937223855, 4434.822607095744, 4435.933460998088, 4462.933056004163, 4491.124230774967, 4508.706934049276, 4921.8523444296725, 5189.325387699575, 5192.402873669501, 5202.089634314056, 5202.219667049897, 4378.190034843564, 4392.077663690597, 4395.1429471252795, 4400.1199760047475, 4437.156940181355, 4562.133194692998, 4618.237990731559, 4627.629789616823, 4654.953450465519, 4697.882552936204, 4907.214845624683, 4907.631927605373, 4940.92588611164, 4949.90100197994, 5013.674111182689, 4905.166121759381, 5029.170186919117, 5254.9474505255985, 5288.9735551322, 5381.434949330421, 4885.8045678172475, 4965.702057876539, 4972.975135124301, 4974.253861920741, 5009.974950125226, 4789.281607758725, 5161.509656582619, 5187.688738675692, 5191.32512773337, 5195.532402083831, 4986.077575648516, 5082.923756143735, 5138.177891537336, 5163.044836705221, 5203.089459344524, 4992.675476094042, 5030.195168773125, 5032.6477146600855, 5041.0422019816115, 5069.847904562869, 4768.856934291838, 4932.580730637793, 5006.4743201963265, 5023.6985780853265, 5033.622478314214, 4865.805367785249, 4877.3903262092235, 4898.461169271306, 4950.45544990058, 4985.1276026695905, 5033.169527028146, 5062.291279220985, 5071.112555302733, 5081.542661160365, 5090.974545127398, 4674.135284972291, 4934.901301974012, 4944.554990050912, 4957.082939656175, 4987.2768448574025], "unit": "score", "name": "dojo.html", "value": 4720.681599681251}, {"lowerIsBetter": false, "replicates": [564.8448921954603, 573.260493962788, 577.5437404450485, 578.0750798722044, 584.0509172594534, 34621.30757384854, 35222.119447013836, 35260.64739352606, 35287.0, 35321.82339088307, 39344.409833852515, 39823.601763982355, 39832.40251396224, 39853.80073099631, 40003.0, 7938.761837144895, 8078.919210807875, 8102.473339232961, 8117.878231826528, 8126.10612832588, 7867.134615192324, 7921.36629069673, 7987.201279872024, 8017.518948863058, 8022.839543209132, 7911.090224624156, 7958.960205198995, 7983.920160798376, 8015.639296231654, 8021.879671804928, 7719.768406947773, 7763.72826951054, 7771.494852834548, 7797.337226335769, 7801.5709135997495, 7901.841963160762, 8017.0, 8046.919530804676, 8057.838843223161, 8064.193580641948, 35834.28331433383, 36449.81775091134, 36567.26865462703, 36582.08544786375, 36712.0, 2422.573435504475, 2936.398038402144, 2970.8366039867797, 3100.5039193728894, 3143.3556120995368, 26395.604065939027, 30213.395732085235, 31315.686843131505, 31372.843135784176, 32737.672623273702, 3135.1221657935816, 3140.7487401007866, 3152.653208147102, 3165.2878102427, 3183.4588120019653, 176791.11604441894, 177649.0, 178056.0, 178629.9999999987, 178632.0, 49094.0, 49112.0, 49209.0, 50304.74847625739, 51756.0, 63154.0, 64304.0, 64419.35580644134, 64499.77501124925, 64578.0, 13005.21968681882, 13184.0, 13271.867281327257, 13307.401166947511, 13317.600471985856, 10793.298435601819, 10906.127509799197, 10937.507812148473, 10963.0, 10988.120950323955, 18089.54776130581, 18404.35584754554, 18415.90792046031, 18453.354132605295, 18464.446066618024, 6871.415929646036, 7074.646267686595, 7133.5719856808755, 7140.6072666003865, 7261.164966028869, 821.3100995164091, 839.345310657688, 943.8253923024263, 1023.81059503992, 1032.2980373346197, 24339.756602434103, 24477.755222447548, 24558.386040349134, 24594.385140371276, 24612.261632150705, 926.6478738079487, 947.5262368815593, 1076.1659713721929, 1090.7436752363187, 1111.1999360460457, 12909.225446473241, 13074.757897999674, 13092.923163056674, 13254.469821207236, 13424.530141445002, 322982.0, 328890.0, 331584.0, 331743.0, 332952.0, 46598.301025484645, 47083.529164707914, 47306.0, 47338.5266147341, 47516.762416187696, 1200.7298357869583, 1211.5638370186725, 1223.687959570304, 1234.919730217515, 1241.8385609870659, 23833.88083059643, 23845.258118773698, 29383.55924661089, 29966.400671986874, 30401.391972159992, 43630.34554481622, 44213.33679994867, 44327.556724433634, 44373.33439998467, 44381.556184437744, 247791.0, 250459.0, 252143.0, 252156.0, 252267.0, 38405.0, 38528.0, 38758.224835502566, 38773.612263877, 38997.2200555993, 35782.64217357793, 38044.23911521699, 38192.85421437361, 38279.61720382872, 38630.42054369243, 31916.202094946882, 32001.0, 32586.837065814518, 32917.341653166324, 32926.50610240896, 32365.676343236268, 32554.674453255164, 32827.17932051718, 32917.0, 33068.33863322672, 32836.179095522806, 33304.83347583246, 33461.83269083639, 33585.0, 33654.495182571794, 27924.441511169258, 29337.266568335963, 29548.0, 29595.049504950493, 29799.0, 23425.531489370456, 23789.405264868517, 24010.51978960446, 24056.15803446871, 24124.27627171188], "unit": "score", "name": "ext.html", "value": 16964.127057446003}, {"lowerIsBetter": false, "replicates": [315.1051015117067, 315.6874694052888, 316.7054639185557, 325.12217014062026, 327.7361723812332, 12608.432620532076, 12985.80521292179, 15157.621059473518, 15504.534863954072, 15904.920475397636, 15938.52184434466, 16237.594060148502, 16463.094529800856, 16473.176341182952, 16483.0, 4810.350602668647, 5024.698518088908, 5028.2709007193935, 5039.19372900336, 5041.52105549974, 4964.156093464102, 4992.151334273164, 5111.84664460065, 5134.563562097226, 5145.485451454862, 5020.0963826511215, 5101.260317253996, 5125.871853203681, 5130.692158470485, 5328.0, 5284.788608455658, 5288.338957630296, 5291.232771248186, 5307.814226502092, 5310.362756469229, 4838.322634831126, 5085.567726743231, 5099.796008159669, 5108.974455127738, 5123.692578445268, 11547.422628868608, 11689.298642081503, 11693.0, 11719.824202636968, 11816.409179540988, 1763.973540396895, 1781.536800431884, 1857.4149143019906, 1885.5097674604701, 1932.294712429967, 8350.33197344211, 8449.662013519452, 8454.746357609281, 8483.787905302417, 8713.912860871373, 1721.7494557688526, 1736.9826301736948, 1749.2215963896072, 1769.8849574777598, 1809.782826060868, 54159.458405416226, 54931.725341373436, 55510.16734748982, 58280.70859645717, 59079.40920590782, 9604.183644390305, 9816.65641702537, 9882.4564648945, 9922.702318930444, 9939.701808945743, 12728.1726687765, 12765.617031488884, 12768.61694149177, 12786.680332991564, 12794.616161515169, 7016.92983070173, 7344.522606030698, 7368.37368823656, 7373.520721153108, 7393.260673932564, 7070.222275549685, 7121.181064177686, 7133.108361454818, 7151.821204469826, 7177.3899218567, 4139.523954745183, 4226.5139508956245, 4227.7463352198965, 4257.446531950888, 7472.0, 3071.738902193294, 3140.952885706716, 3145.191514878954, 3196.38582515828, 3201.695838895301, 364.4078372644453, 368.382958544437, 415.488948593226, 822.6791551294999, 876.8334016536837, 9392.248620110375, 9497.810043799085, 9632.566534505964, 9814.165795907427, 9949.0, 390.64451349272025, 395.539196835689, 396.49644950912756, 398.040721860321, 414.65583565640446, 5290.9736348769675, 5356.116240820299, 5382.892342153135, 5389.245505629215, 5426.050441172858, 483935.0, 488771.0, 492116.0, 503217.0, 509072.0, 71911.64044179746, 73160.63419682973, 73685.6315718418, 74277.0, 74909.62545187239, 436.38687643860425, 439.8570464599018, 441.46141707117266, 442.07826681369704, 443.1668463288996, 9355.766105847137, 9430.292728045286, 9558.187554057982, 9568.330216884751, 9614.134727874525, 30555.0, 31138.37723245477, 31428.84285578649, 31528.0, 31853.0, 44352.55647443613, 45045.32432013457, 45839.31241031454, 45939.0, 51500.227496586835, 8079.111297757125, 8269.793255168428, 8366.0, 8384.622691978997, 8406.117357677356, 15418.383264669736, 15927.283272253007, 15945.760813587573, 15998.120103394425, 16406.0, 13641.931790340985, 13706.657333566342, 13935.721285574435, 14052.367643456273, 14102.224377659328, 12915.806262905877, 13085.67285817824, 13446.260455675032, 13822.10156339875, 13907.096038757853, 8619.956900215459, 8927.375083744335, 13705.657358566115, 13976.510822121178, 14186.503472378417, 13163.47346106145, 13548.119372240773, 13708.040437169302, 13813.447462101403, 14031.087979281314, 13166.0, 14793.038452500554, 14992.2503874808, 15238.466653667068, 15536.223188840739], "unit": "score", "name": "jquery.html", "value": 7679.5600045064175}, {"lowerIsBetter": false, "replicates": [1430.5922811998582, 1640.5652502086948, 1691.7208660571007, 1710.4099085815396, 1719.5872990482285, 5988.191594134791, 6257.687115644222, 6902.4478041756665, 7450.292222238885, 7463.402927765773, 6980.546264492805, 7077.964610176942, 7164.4626653001105, 7183.784486465414, 7224.7471338503165, 2051.159024799829, 2070.896455177243, 2076.4705000225, 2088.8224500917363, 2092.5082605587677, 2081.4484161697164, 2100.747910250772, 2121.9257325993594, 2156.91372345106, 2165.8050775430206, 2048.1193086972594, 2065.0500769645982, 2078.0752565108533, 2078.688196770489, 2083.104265165978, 2080.5942841145907, 2112.0812446585633, 2112.7042214090116, 2114.598226336999, 2117.851750377474, 2096.444442222812, 2113.545587698652, 2120.4380839077658, 2122.586095711337, 2126.766055733868, 7296.087989001375, 7365.852682946311, 7383.114026316823, 7383.889241661379, 7387.963060184718, 4262.0, 4320.567943205686, 4322.783860806947, 4322.913541729148, 4322.978385108086, 2690.7174746651517, 2702.0, 2810.9578356324673, 2837.560178172366, 2843.431313737261, 837.2422957223662, 866.5580553917484, 882.3691060891493, 887.5739644970386, 900.4237288135533, 9721.513924303756, 9768.413895166384, 9837.80324393508, 9847.458389788559, 9852.064053914866, 3888.844446222176, 3898.317794385971, 3954.9604503955165, 4002.779847108437, 4023.75857448554, 8487.151284871587, 8492.235698787015, 8503.532305723122, 8504.107068757816, 8519.020312664123, 4389.802458889294, 4395.956040439619, 4402.25161722508, 4402.713823601455, 4411.867643970686, 3242.854071566785, 3274.590676165479, 3761.5298087739034, 3985.960140398559, 4014.41790940312, 3403.2342722887647, 3436.9656303437146, 3443.8450269737923, 3477.4783782432837, 3491.6159222485508, 1108.2685427617735, 1125.1224045244721, 1137.4938152522047, 1144.227646338718, 1163.906887449002, 948.8197242523898, 961.5721004153224, 986.0, 992.4194346307347, 999.5901680311038, 6870.0, 6875.724971001204, 6879.484038697117, 6890.10428644273, 6917.169939607279, 408.8058172368101, 410.89316777638027, 413.3881854854832, 424.312613566025, 426.6032589691617, 5211.114110601131, 5259.316288882421, 5279.260903473517, 5279.260903473517, 5279.498447647467, 8450.112738162527, 8549.743507694779, 8806.735797926072, 8821.69124080667, 8910.86633700495, 8611.913880861237, 8648.913510864937, 8666.133386661284, 8762.86855697165, 8778.253848422828, 6802.693878775467, 6877.3810357068105, 6957.0, 6975.128108986478, 6989.790306290819, 6556.541042127196, 6571.638559879252, 6575.572587781779, 6594.538382313192, 6596.70314835824, 7623.809404764926, 7633.1985141559335, 7861.921380786119, 7886.369090472863, 7906.407019473448, 7805.868149118232, 8047.919520804951, 8107.675692972215, 8121.959390203011, 8152.633131509215, 5269.552088072557, 5514.751836167462, 6278.277998030285, 6515.511336649865, 6517.348265173445, 6962.7214911405, 6966.721331146698, 6971.337722916518, 7007.929920700932, 7009.12385951756, 6320.873582528416, 6457.4511166551365, 6506.308359826385, 6590.7693230736695, 6633.834154145992, 6417.133686952202, 6439.130717353098, 6466.935330646634, 6510.381513756186, 6531.052997315458, 6502.60984340941, 6530.444912182517, 6530.6081635100145, 6533.150690410406, 6539.182602174728, 5800.042992906292, 5805.10020946754, 5812.389699081536, 5969.850753731192, 5978.163057171912, 6051.001584738468, 6070.484008859296, 6071.3625069368845, 6073.5748497604745, 6073.726682299219], "unit": "score", "name": "mootools.html", "value": 4041.345610702721}, {"lowerIsBetter": false, "replicates": [285.44623430544743, 292.56700083875864, 297.15755832215666, 297.2716843732855, 297.96275465566805, 5556.16657501375, 5600.495955364022, 5629.60592758507, 5634.239377684022, 5654.293213348332, 5524.33707955045, 5533.142362933751, 5534.584906132046, 5537.0, 5553.416891226424, 4297.0, 4305.246581848171, 4305.332673435622, 4307.590778876001, 4308.9784551077355, 4037.9703175690156, 4129.0, 4170.936411215151, 4306.332518459628, 4315.676324275676, 4250.213710463574, 4258.127083947783, 4270.12462445198, 4274.187904298189, 4277.957220427787, 4249.0, 4270.231358355495, 4271.97864010681, 4277.657787377034, 4287.721298115644, 3720.8325625346924, 3740.2893450244364, 3741.064733816546, 3749.137698329372, 3763.9247215055548, 5273.789048438058, 5422.349318081855, 5438.564914806806, 5448.237246785414, 5468.0977638689565, 4863.586595139417, 4865.756712164378, 4870.0, 4878.463369029404, 4880.389951256093, 5865.970670146665, 5896.734646940855, 5902.996490596609, 5907.172995780594, 5908.556858235649, 3970.960290397088, 3973.046468847485, 3974.880753577397, 3979.7612143271494, 3981.880543583697, 5920.674362910038, 6080.9391906081255, 6149.631022138686, 6181.289151747562, 6196.039613859859, 4027.9798601006805, 4069.4506241656995, 4070.226656935232, 4088.836446542105, 4089.91820163601, 4124.752514849119, 4140.254754144223, 4145.7719825409895, 4150.27370210212, 4152.709310348247, 4808.495108013678, 4810.759462026885, 4812.831550895772, 4819.518048195152, 4830.9275360869615, 5710.400407957188, 5839.357670656224, 5845.561582881301, 5847.0, 5849.532037436995, 1438.3958737330138, 1457.0893191755154, 1461.0211158523814, 1461.6053665510465, 1462.795208670787, 944.8015916657579, 947.8436058050482, 962.2782912815388, 966.9274804389559, 974.4153507895348, 5113.718745469035, 5120.1039818031695, 5124.180131178993, 5131.512506311894, 5136.101182293084, 5872.677002764804, 6014.51883849291, 6071.453569178795, 6106.145139680449, 6124.663143527148, 5144.074066668036, 5148.742562871841, 5153.871153221199, 5173.1722924331925, 5180.533751962342, 3289.8190599517256, 3302.488114342281, 3316.4196265653413, 3319.2033911861463, 3328.9680199138343, 5639.915401268984, 5744.971275143597, 5754.856128596819, 5758.62568933018, 5759.827205183851, 6270.2475702915945, 6311.368863113744, 6323.20959880015, 6325.987841945267, 6332.905006424908, 5730.398308177581, 5735.541156707453, 5752.511036561856, 5755.7409916553015, 5775.595708300379, 6180.629162250099, 6184.752609895734, 6191.318954914866, 6192.81421557354, 6202.255729312331, 5887.499562537232, 5983.311919129182, 5996.220491336098, 6000.0999850022845, 6002.189704389852, 5767.163761254678, 5772.39389864075, 5773.364929857797, 5778.191053252632, 5791.189233507228, 4066.9389959151226, 4067.2678917795083, 4069.1861627673993, 4073.45008423859, 4077.8164982575263, 5990.041593345044, 6133.141360209664, 6154.507639388928, 6158.0, 6166.414190651881, 5900.734466948912, 5916.053431450947, 5919.4968427684125, 5921.259842519685, 5936.406359364029, 5911.172435859069, 5915.822525324247, 5921.733521991435, 5924.851878703067, 5930.881382372242, 5689.431056894443, 5725.484706376446, 5790.710464476675, 5804.94195058044, 5808.070708686759, 5979.192808970907, 5983.311919129356, 5983.880322393615, 5983.910241346296, 5993.0, 5834.504067154339, 5842.737076831468, 5844.3571207168025, 5844.415558444121, 5845.766169353348], "unit": "score", "name": "prototype.html", "value": 4372.243700826837}, {"lowerIsBetter": false, "replicates": [633.3508154142003, 641.3298103481861, 700.9345794392523, 785.520832292302, 821.7411515372661, 10487.790244195121, 10532.894671053287, 10574.312669676465, 10617.469126543661, 10619.893801061988, 10967.287126336783, 11713.941430292858, 11722.23805452645, 11778.528858845657, 11794.29234245946, 630.6941133550224, 637.2926052082186, 780.7423550228425, 788.4402074527093, 805.3758337288618, 783.7217787685375, 789.8854666073416, 791.5329955326356, 793.5556088590379, 797.3023604346197, 825.0553116681397, 827.2265431821236, 827.9461834980707, 828.6064119543199, 834.8330333933208, 812.6058861452191, 813.8128230506987, 813.9552324622143, 817.6851912013888, 818.6397984886631, 604.6402390577599, 605.5821483176638, 607.3501353551701, 609.3053918532831, 610.2402508876477, 10925.399103049329, 11062.834057489064, 11077.889221107847, 11082.833757493645, 11088.722781930435, 10618.203634727426, 10700.464976751131, 11084.445777711082, 11232.157588180919, 11413.258138220988, 9189.310801689833, 9314.115159059946, 9481.620735170585, 9487.573059212353, 9545.90454095457, 3034.893778717734, 3077.338372249955, 3108.456020196479, 3123.120735155965, 3124.297033167542, 38321.42517862206, 38393.232135357415, 38595.8421247363, 38757.41863872044, 38841.417378739345, 9064.410813297114, 9083.863742043875, 9306.581203845843, 9358.672446464341, 9386.249100071978, 16466.75299870503, 16495.91752041232, 16505.33978640841, 16507.504774856774, 16511.669766604842, 6335.936640633627, 6339.175907132043, 6421.325760795049, 6476.287608363076, 6506.479481641457, 3653.8173091345325, 3658.158623516553, 3688.3360995020616, 3693.279810436939, 3726.2174943261675, 2557.0794513974956, 2583.134649892307, 2595.480903819206, 2601.8308809927294, 2602.9349266268496, 443.45898004434537, 464.90934267818125, 468.4168210577852, 471.07433892401593, 475.89768199837204, 528.3422139436426, 528.7594144664246, 548.5748544877752, 587.136908744154, 589.0869152813123, 7176.856462870714, 7696.307332340116, 8194.623559167774, 8458.703945361884, 8723.127687231226, 561.6854561445604, 613.2303958532013, 617.8455386153462, 624.6345887655682, 626.7023163997065, 3478.1652403423504, 3533.611302756695, 3619.8190090495896, 3723.6834869036434, 3826.081740382344, 49281.507184927694, 49362.75318623456, 49850.25224621633, 50034.49965500371, 50230.0, 43063.784681076395, 43309.56690433119, 43485.78257108758, 43996.780016099714, 44116.55883441125, 40480.1903961925, 41131.0, 41282.793586031876, 41303.586964130576, 41757.37363939543, 7487.6630551626395, 7712.035995500562, 7742.341900938258, 8010.078840933134, 8036.758897233092, 30073.398532029674, 30534.236644084074, 30583.847080764455, 31256.687433126288, 31422.842885785423, 36925.446118308784, 40208.79373618796, 40550.79724601358, 40570.79714601408, 40642.79678601588, 9859.605615775288, 9885.95057024739, 9945.204383649436, 9955.153811925778, 10270.0, 10982.450877456255, 11385.829212561985, 11630.185886987829, 11863.228890122115, 12067.81898271509, 9985.550650220903, 10144.543495542866, 10184.847227291744, 10344.844827327746, 10824.24230303871, 9614.278929080487, 9614.90385096168, 9723.416595004323, 9767.755806104904, 9898.950505247716, 9353.345265831327, 9363.906360936304, 9508.572114254737, 9685.32202745801, 9743.512824358611, 8949.955250223707, 9037.593308301273, 9165.587548560197, 9253.67612133572, 9478.763030924281, 8531.189536993976, 8908.153725396078, 8988.146126118008, 9026.277897768294, 9080.318976076689], "unit": "score", "name": "yui.html", "value": 5614.965771718532}], "name": "dromaeo_css", "value": 6274.544001274744}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 112.0, 114.0, 115.0, 123.0, 121.0, 111.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 150.0, 164.0, 139.0, 155.0, 155.0, 137.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 182.0, 164.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 71.0, 76.0, 136.0, 73.0, 78.0, 74.0, 74.0, 88.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 95.0, 100.0, 94.0, 141.0, 95.0, 95.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 79.0, 74.0, 76.0, 75.0, 77.0, 85.0, 73.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 76.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 93.0, 86.0, 84.0, 84.0, 83.0, 88.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [125.0, 128.0, 120.0, 128.0, 135.0, 141.0, 123.0, 122.0, 126.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 149.0, 146.0, 146.0, 140.0, 146.0, 146.0, 139.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 69.0, 72.0, 69.0, 70.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1539.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [191.8649270913277], "unit": "score", "name": "DeltaBlue", "value": 344.60701600000004}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [720.4610951008646], "unit": "score", "name": "Earley", "value": 925.050644}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [597.2797161442933], "unit": "score", "name": "Splay", "value": 136.43691188118814}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21287.58884528143}]} 02:54:00 INFO - RETURN: dromaeo_css: 6274.55 02:54:00 INFO - RETURN: kraken: 1539.80 02:54:00 INFO - RETURN: v8_7: 21287.59 02:54:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21287.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1539.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6274.55"}}} 02:54:00 INFO - Return code: 0 02:54:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:54:00 INFO - # TBPL SUCCESS # 02:54:00 INFO - Running post-action listener: _resource_record_post_action 02:54:00 INFO - Running post-run listener: _resource_record_post_run 02:54:01 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544874496; Read time: 164; Write time: 615916 02:54:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226922496; Read time: 0; Write time: 317532 02:54:01 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316940288; Read time: 164; Write time: 298344 02:54:01 INFO - Running post-run listener: _upload_blobber_files 02:54:01 INFO - Blob upload gear active. 02:54:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:54:01 INFO - Copying logs to upload dir... 02:54:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.955357 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-20 02:54:00.639777) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:54:00.643768) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010038 build_url: 'https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:54:00.696295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:54:00.696731) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450591613.320642-326472185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:54:00.750022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 02:54:00.750789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 02:54:00.751440) ========= ========= Total master_lag: 0.27 =========