builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1462356248.14 results: success (0) buildid: 20160504020551 builduid: 4ed8f91ef290445ea2d6563f12b39492 revision: e02797aae3cea963d11f2bffefe397b1f3159554 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.141063) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.141641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.141992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.224415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.224830) ========= 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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 03:04:08-- 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% 50.0M=0s 2016-05-04 03:04:08 (50.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.361207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.361997) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015736 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:08.416128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 03:04:08.416901) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e02797aae3cea963d11f2bffefe397b1f3159554 --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 e02797aae3cea963d11f2bffefe397b1f3159554 --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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 03:04:08,646 truncating revision to first 12 chars 2016-05-04 03:04:08,646 Setting DEBUG logging. 2016-05-04 03:04:08,646 attempt 1/10 2016-05-04 03:04:08,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e02797aae3ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 03:04:09,883 unpacking tar archive at: fx-team-e02797aae3ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.548528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 03:04:09.980126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:09.980501) ========= script_repo_revision: e02797aae3cea963d11f2bffefe397b1f3159554 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:09.981011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:09.981342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 03:04:09.993079) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 32 secs) (at 2016-05-04 03:04:09.993872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:10 INFO - MultiFileLogger online at 20160504 03:04:10 in /builds/slave/test 03:04:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:04:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:10 INFO - {'append_to_log': False, 03:04:10 INFO - 'base_work_dir': '/builds/slave/test', 03:04:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:04:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:10 INFO - 'branch': 'Fx-Team-Non-PGO', 03:04:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:10 INFO - 'config_files': ('talos/linux_config.py',), 03:04:10 INFO - 'default_actions': ('clobber', 03:04:10 INFO - 'read-buildbot-config', 03:04:10 INFO - 'download-and-extract', 03:04:10 INFO - 'populate-webroot', 03:04:10 INFO - 'create-virtualenv', 03:04:10 INFO - 'install', 03:04:10 INFO - 'run-tests'), 03:04:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:10 INFO - 'download_minidump_stackwalk': True, 03:04:10 INFO - 'download_symbols': 'ondemand', 03:04:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:10 INFO - 'installer_path': 'installer.exe', 03:04:10 INFO - 'log_level': 'info', 03:04:10 INFO - 'log_name': 'talos', 03:04:10 INFO - 'log_to_console': True, 03:04:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:10 INFO - 'opt_config_files': (), 03:04:10 INFO - 'pip_index': False, 03:04:10 INFO - 'sps_profile': False, 03:04:10 INFO - 'sps_profile_interval': 0, 03:04:10 INFO - 'suite': 'dromaeojs-e10s', 03:04:10 INFO - 'system_bits': '32', 03:04:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:10 INFO - 'title': 'talos-linux64-ix-052', 03:04:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:10 INFO - 'use_talos_json': True, 03:04:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:10 INFO - 'work_dir': 'build'} 03:04:10 INFO - ##### 03:04:10 INFO - ##### Running clobber step. 03:04:10 INFO - ##### 03:04:10 INFO - Running pre-action listener: _resource_record_pre_action 03:04:10 INFO - Running main action method: clobber 03:04:10 INFO - rmtree: /builds/slave/test/build 03:04:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:11 INFO - Running post-action listener: _resource_record_post_action 03:04:11 INFO - ##### 03:04:11 INFO - ##### Running read-buildbot-config step. 03:04:11 INFO - ##### 03:04:11 INFO - Running pre-action listener: _resource_record_pre_action 03:04:11 INFO - Running main action method: read_buildbot_config 03:04:11 INFO - Using buildbot properties: 03:04:11 INFO - { 03:04:11 INFO - "project": "", 03:04:11 INFO - "product": "firefox", 03:04:11 INFO - "script_repo_revision": "production", 03:04:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:04:11 INFO - "repository": "", 03:04:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:04:11 INFO - "buildid": "20160504020551", 03:04:11 INFO - "pgo_build": "False", 03:04:11 INFO - "basedir": "/builds/slave/test", 03:04:11 INFO - "buildnumber": 1470, 03:04:11 INFO - "slavename": "talos-linux64-ix-052", 03:04:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:04:11 INFO - "platform": "ubuntu64_hw", 03:04:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:04:11 INFO - "branch": "fx-team", 03:04:11 INFO - "repo_path": "integration/fx-team", 03:04:11 INFO - "revision": "e02797aae3cea963d11f2bffefe397b1f3159554", 03:04:11 INFO - "stage_platform": "linux64", 03:04:11 INFO - "builduid": "4ed8f91ef290445ea2d6563f12b39492", 03:04:11 INFO - "slavebuilddir": "test" 03:04:11 INFO - } 03:04:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:04:11 INFO - Running post-action listener: _resource_record_post_action 03:04:11 INFO - ##### 03:04:11 INFO - ##### Running download-and-extract step. 03:04:11 INFO - ##### 03:04:11 INFO - Running pre-action listener: _resource_record_pre_action 03:04:11 INFO - Running main action method: download_and_extract 03:04:11 INFO - mkdir: /builds/slave/test/build/tests 03:04:11 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')]} 03:04:11 INFO - https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:04:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:04:41 INFO - retry: attempt #1 caught exception: timed out 03:04:41 INFO - retry: Failed, sleeping 30 seconds before retrying 03:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:05:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:05:41 INFO - retry: attempt #2 caught exception: timed out 03:05:41 INFO - retry: Failed, sleeping 60 seconds before retrying 03:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:07:11 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:07:11 INFO - retry: attempt #3 caught exception: timed out 03:07:11 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json! 03:07:11 INFO - Caught exception: timed out 03:07:11 INFO - Caught exception: timed out 03:07:11 INFO - Caught exception: timed out 03:07:11 INFO - trying https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:07:12 INFO - Downloaded 1361 bytes. 03:07:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:12 INFO - Using the following test package requirements: 03:07:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:07:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:07:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'jsshell-linux-x86_64.zip'], 03:07:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:07:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:07:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:07:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:07:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:07:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:07:12 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')]} 03:07:12 INFO - https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:07:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:07:42 INFO - retry: attempt #1 caught exception: timed out 03:07:42 INFO - retry: Failed, sleeping 30 seconds before retrying 03:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:08:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:08:42 INFO - retry: attempt #2 caught exception: timed out 03:08:42 INFO - retry: Failed, sleeping 60 seconds before retrying 03:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:10:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:10:12 INFO - retry: attempt #3 caught exception: timed out 03:10:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 03:10:12 INFO - Caught exception: timed out 03:10:12 INFO - Caught exception: timed out 03:10:12 INFO - Caught exception: timed out 03:10:12 INFO - trying https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:10:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:13 INFO - Downloaded 22305784 bytes. 03:10:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:10:14 INFO - Return code: 0 03:10:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:10:14 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')]} 03:10:14 INFO - https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:10:44 INFO - retry: attempt #1 caught exception: timed out 03:10:44 INFO - retry: Failed, sleeping 30 seconds before retrying 03:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:11:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:11:44 INFO - retry: attempt #2 caught exception: timed out 03:11:44 INFO - retry: Failed, sleeping 60 seconds before retrying 03:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:13:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:13:14 INFO - retry: attempt #3 caught exception: timed out 03:13:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 03:13:14 INFO - Caught exception: timed out 03:13:14 INFO - Caught exception: timed out 03:13:14 INFO - Caught exception: timed out 03:13:14 INFO - trying https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:13:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:13:15 INFO - Downloaded 22305784 bytes. 03:13:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:13:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:13:17 INFO - Return code: 0 03:13:17 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')]} 03:13:17 INFO - https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:13:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:13:47 INFO - retry: attempt #1 caught exception: timed out 03:13:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:14:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:14:47 INFO - retry: attempt #2 caught exception: timed out 03:14:47 INFO - retry: Failed, sleeping 60 seconds before retrying 03:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:16:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:16:17 INFO - retry: attempt #3 caught exception: timed out 03:16:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip! 03:16:17 INFO - Caught exception: timed out 03:16:17 INFO - Caught exception: timed out 03:16:17 INFO - Caught exception: timed out 03:16:17 INFO - trying https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:16:18 INFO - Downloaded 10840152 bytes. 03:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:16:18 INFO - Return code: 0 03:16:18 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')]} 03:16:18 INFO - https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:16:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:16:48 INFO - retry: attempt #1 caught exception: timed out 03:16:48 INFO - retry: Failed, sleeping 30 seconds before retrying 03:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:17:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:17:48 INFO - retry: attempt #2 caught exception: timed out 03:17:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:19:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:19:18 INFO - retry: attempt #3 caught exception: timed out 03:19:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 03:19:18 INFO - Caught exception: timed out 03:19:18 INFO - Caught exception: timed out 03:19:18 INFO - Caught exception: timed out 03:19:18 INFO - trying https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:19:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:19:19 INFO - Downloaded 54922871 bytes. 03:19:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:19:19 INFO - mkdir: /builds/slave/test/properties 03:19:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:19 INFO - Contents: 03:19:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:19:20 INFO - Running post-action listener: _resource_record_post_action 03:19:20 INFO - Running post-action listener: set_extra_try_arguments 03:19:20 INFO - ##### 03:19:20 INFO - ##### Running populate-webroot step. 03:19:20 INFO - ##### 03:19:20 INFO - Running pre-action listener: _resource_record_pre_action 03:19:20 INFO - Running main action method: populate_webroot 03:19:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:19:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:19:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:19:20 INFO - '--tppagecycles', 03:19:20 INFO - '7'], 03:19:20 INFO - 'tests': ['tsvgm']}}, 03:19:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:19:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:19:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['damp', 'tps']}, 03:19:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'tests': ['damp', 'tps']}, 03:19:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['dromaeo_dom']}, 03:19:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['a11yr', 03:19:20 INFO - 'ts_paint', 03:19:20 INFO - 'tpaint', 03:19:20 INFO - 'sessionrestore', 03:19:20 INFO - 'sessionrestore_no_auto_restore', 03:19:20 INFO - 'tabpaint']}, 03:19:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['tsvgx', 03:19:20 INFO - 'tsvgr_opacity', 03:19:20 INFO - 'tart', 03:19:20 INFO - 'tscrollx', 03:19:20 INFO - 'cart']}, 03:19:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:20 INFO - 'tsvgr_opacity', 03:19:20 INFO - 'tart', 03:19:20 INFO - 'tscrollx', 03:19:20 INFO - 'cart']}, 03:19:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'talos_options': ['--disable-e10s'], 03:19:20 INFO - 'tests': ['tp5o']}, 03:19:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'tests': ['tp5o']}, 03:19:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'talos_options': ['--disable-e10s', 03:19:20 INFO - '--xperf_path', 03:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:20 INFO - 'tests': ['tp5n']}, 03:19:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:20 INFO - 'talos_options': ['--xperf_path', 03:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:20 INFO - 'tests': ['tp5n']}}, 03:19:20 INFO - 'talos.zip': {'path': '', 03:19:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:19:20 INFO - Running post-action listener: _resource_record_post_action 03:19:20 INFO - ##### 03:19:20 INFO - ##### Running create-virtualenv step. 03:19:20 INFO - ##### 03:19:20 INFO - Running pre-action listener: _resource_record_pre_action 03:19:20 INFO - Running main action method: create_virtualenv 03:19:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:20 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 03:19:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:20 INFO - Using real prefix '/usr' 03:19:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:23 INFO - Installing pip.................done. 03:19:23 INFO - Return code: 0 03:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:23 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')]} 03:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:23 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')]} 03:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:23 INFO - Using env: {'DISPLAY': ':0', 03:19:23 INFO - 'HOME': '/home/cltbld', 03:19:23 INFO - 'LANG': 'en_US.UTF-8', 03:19:23 INFO - 'LANGUAGE': 'en_US:en', 03:19:23 INFO - 'LOGNAME': 'cltbld', 03:19:23 INFO - 'MAIL': '/var/mail/cltbld', 03:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:23 INFO - 'MOZ_NO_REMOTE': '1', 03:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:23 INFO - 'NO_EM_RESTART': '1', 03:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:23 INFO - 'PWD': '/builds/slave/test', 03:19:23 INFO - 'SHELL': '/bin/bash', 03:19:23 INFO - 'SHLVL': '1', 03:19:23 INFO - 'TERM': 'linux', 03:19:23 INFO - 'TMOUT': '86400', 03:19:23 INFO - 'USER': 'cltbld', 03:19:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:23 INFO - '_': '/tools/buildbot/bin/python'} 03:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:23 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 03:19:23 INFO - Cleaning up... 03:19:23 INFO - Return code: 0 03:19:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:19:23 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')]} 03:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:23 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')]} 03:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:23 INFO - Using env: {'DISPLAY': ':0', 03:19:23 INFO - 'HOME': '/home/cltbld', 03:19:23 INFO - 'LANG': 'en_US.UTF-8', 03:19:23 INFO - 'LANGUAGE': 'en_US:en', 03:19:23 INFO - 'LOGNAME': 'cltbld', 03:19:23 INFO - 'MAIL': '/var/mail/cltbld', 03:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:23 INFO - 'MOZ_NO_REMOTE': '1', 03:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:23 INFO - 'NO_EM_RESTART': '1', 03:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:23 INFO - 'PWD': '/builds/slave/test', 03:19:23 INFO - 'SHELL': '/bin/bash', 03:19:23 INFO - 'SHLVL': '1', 03:19:23 INFO - 'TERM': 'linux', 03:19:23 INFO - 'TMOUT': '86400', 03:19:23 INFO - 'USER': 'cltbld', 03:19:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:23 INFO - '_': '/tools/buildbot/bin/python'} 03:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:23 INFO - Downloading/unpacking psutil>=0.7.1 03:19:23 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 03:19:23 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 03:19:23 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 03:19:23 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 03:19:23 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 03:19:23 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 03:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:25 INFO - Installing collected packages: psutil 03:19:25 INFO - Running setup.py install for psutil 03:19:25 INFO - building 'psutil._psutil_linux' extension 03:19:25 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 03:19:25 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 03:19:25 INFO - building 'psutil._psutil_posix' extension 03:19:25 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 03:19:25 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 03:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:25 INFO - Successfully installed psutil 03:19:25 INFO - Cleaning up... 03:19:26 INFO - Return code: 0 03:19:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:19:26 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')]} 03:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:26 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')]} 03:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:26 INFO - Using env: {'DISPLAY': ':0', 03:19:26 INFO - 'HOME': '/home/cltbld', 03:19:26 INFO - 'LANG': 'en_US.UTF-8', 03:19:26 INFO - 'LANGUAGE': 'en_US:en', 03:19:26 INFO - 'LOGNAME': 'cltbld', 03:19:26 INFO - 'MAIL': '/var/mail/cltbld', 03:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:26 INFO - 'MOZ_NO_REMOTE': '1', 03:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:26 INFO - 'NO_EM_RESTART': '1', 03:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:26 INFO - 'PWD': '/builds/slave/test', 03:19:26 INFO - 'SHELL': '/bin/bash', 03:19:26 INFO - 'SHLVL': '1', 03:19:26 INFO - 'TERM': 'linux', 03:19:26 INFO - 'TMOUT': '86400', 03:19:26 INFO - 'USER': 'cltbld', 03:19:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:26 INFO - '_': '/tools/buildbot/bin/python'} 03:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:19:26 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 03:19:26 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 03:19:26 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 03:19:26 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 03:19:26 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 03:19:26 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 03:19:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:19:28 INFO - Installing collected packages: mozsystemmonitor 03:19:28 INFO - Running setup.py install for mozsystemmonitor 03:19:28 INFO - Successfully installed mozsystemmonitor 03:19:28 INFO - Cleaning up... 03:19:28 INFO - Return code: 0 03:19:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19:28 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')]} 03:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:28 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')]} 03:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:28 INFO - Using env: {'DISPLAY': ':0', 03:19:28 INFO - 'HOME': '/home/cltbld', 03:19:28 INFO - 'LANG': 'en_US.UTF-8', 03:19:28 INFO - 'LANGUAGE': 'en_US:en', 03:19:28 INFO - 'LOGNAME': 'cltbld', 03:19:28 INFO - 'MAIL': '/var/mail/cltbld', 03:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:28 INFO - 'MOZ_NO_REMOTE': '1', 03:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:28 INFO - 'NO_EM_RESTART': '1', 03:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:28 INFO - 'PWD': '/builds/slave/test', 03:19:28 INFO - 'SHELL': '/bin/bash', 03:19:28 INFO - 'SHLVL': '1', 03:19:28 INFO - 'TERM': 'linux', 03:19:28 INFO - 'TMOUT': '86400', 03:19:28 INFO - 'USER': 'cltbld', 03:19:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:28 INFO - '_': '/tools/buildbot/bin/python'} 03:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:28 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 03:19:28 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 03:19:28 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 03:19:28 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 03:19:28 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 03:19:28 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 03:19:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:30 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 03:19:31 INFO - Downloading docopt-0.6.1.tar.gz 03:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:31 INFO - Running setup.py install for blobuploader 03:19:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:31 INFO - Running setup.py install for requests 03:19:31 INFO - Running setup.py install for docopt 03:19:31 INFO - Successfully installed blobuploader requests docopt 03:19:31 INFO - Cleaning up... 03:19:31 INFO - Return code: 0 03:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:31 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')]} 03:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:31 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')]} 03:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 03:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 03:19:31 INFO - Using env: {'DISPLAY': ':0', 03:19:31 INFO - 'HOME': '/home/cltbld', 03:19:31 INFO - 'LANG': 'en_US.UTF-8', 03:19:31 INFO - 'LANGUAGE': 'en_US:en', 03:19:31 INFO - 'LOGNAME': 'cltbld', 03:19:31 INFO - 'MAIL': '/var/mail/cltbld', 03:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:31 INFO - 'MOZ_NO_REMOTE': '1', 03:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:31 INFO - 'NO_EM_RESTART': '1', 03:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:31 INFO - 'PWD': '/builds/slave/test', 03:19:31 INFO - 'SHELL': '/bin/bash', 03:19:31 INFO - 'SHLVL': '1', 03:19:31 INFO - 'TERM': 'linux', 03:19:31 INFO - 'TMOUT': '86400', 03:19:31 INFO - 'USER': 'cltbld', 03:19:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:31 INFO - '_': '/tools/buildbot/bin/python'} 03:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:31 INFO - Running setup.py (path:/tmp/pip-tHAXfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:32 INFO - Running setup.py (path:/tmp/pip-_lTsrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:32 INFO - Running setup.py (path:/tmp/pip-7PN16m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:32 INFO - Running setup.py (path:/tmp/pip-Cw7lSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:32 INFO - Running setup.py (path:/tmp/pip-VEnR3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:32 INFO - Running setup.py (path:/tmp/pip-JNGwT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:32 INFO - Running setup.py (path:/tmp/pip-S3Njjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:32 INFO - Running setup.py (path:/tmp/pip-Dglwiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:32 INFO - Running setup.py (path:/tmp/pip-jl5ePv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:32 INFO - Running setup.py (path:/tmp/pip-o5pvkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:32 INFO - Running setup.py (path:/tmp/pip-2T4O6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:32 INFO - Running setup.py (path:/tmp/pip-qETfQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:32 INFO - Running setup.py (path:/tmp/pip-tyD8Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:32 INFO - Running setup.py (path:/tmp/pip-YmkCxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:32 INFO - Running setup.py (path:/tmp/pip-FtQht8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:33 INFO - Running setup.py (path:/tmp/pip-6L2HM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:33 INFO - Running setup.py (path:/tmp/pip-YwFTYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:33 INFO - Running setup.py install for manifestparser 03:19:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:33 INFO - Running setup.py install for mozcrash 03:19:33 INFO - Running setup.py install for mozdebug 03:19:33 INFO - Running setup.py install for mozdevice 03:19:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:33 INFO - Running setup.py install for mozfile 03:19:33 INFO - Running setup.py install for mozhttpd 03:19:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:33 INFO - Running setup.py install for mozinfo 03:19:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:33 INFO - Running setup.py install for mozInstall 03:19:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Running setup.py install for mozleak 03:19:34 INFO - Running setup.py install for mozlog 03:19:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Running setup.py install for moznetwork 03:19:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Running setup.py install for mozprocess 03:19:34 INFO - Running setup.py install for mozprofile 03:19:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Running setup.py install for mozrunner 03:19:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Running setup.py install for mozscreenshot 03:19:34 INFO - Running setup.py install for moztest 03:19:34 INFO - Running setup.py install for mozversion 03:19:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:34 INFO - Cleaning up... 03:19:34 INFO - Return code: 0 03:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:34 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')]} 03:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 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')]} 03:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:34 INFO - Using env: {'DISPLAY': ':0', 03:19:34 INFO - 'HOME': '/home/cltbld', 03:19:34 INFO - 'LANG': 'en_US.UTF-8', 03:19:34 INFO - 'LANGUAGE': 'en_US:en', 03:19:34 INFO - 'LOGNAME': 'cltbld', 03:19:34 INFO - 'MAIL': '/var/mail/cltbld', 03:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:34 INFO - 'MOZ_NO_REMOTE': '1', 03:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:34 INFO - 'NO_EM_RESTART': '1', 03:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:34 INFO - 'PWD': '/builds/slave/test', 03:19:34 INFO - 'SHELL': '/bin/bash', 03:19:34 INFO - 'SHLVL': '1', 03:19:34 INFO - 'TERM': 'linux', 03:19:34 INFO - 'TMOUT': '86400', 03:19:34 INFO - 'USER': 'cltbld', 03:19:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:34 INFO - '_': '/tools/buildbot/bin/python'} 03:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:35 INFO - Running setup.py (path:/tmp/pip-OXqF5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:35 INFO - Running setup.py (path:/tmp/pip-uilK37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:35 INFO - Running setup.py (path:/tmp/pip-1_r40K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:35 INFO - Running setup.py (path:/tmp/pip-Hk1N9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:35 INFO - Running setup.py (path:/tmp/pip-XP0X6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:35 INFO - Running setup.py (path:/tmp/pip-6D5NVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:35 INFO - Running setup.py (path:/tmp/pip-TvKvLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:35 INFO - Running setup.py (path:/tmp/pip-f4nMot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:35 INFO - Running setup.py (path:/tmp/pip-qNjLyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:35 INFO - Running setup.py (path:/tmp/pip-ptOCcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:35 INFO - Running setup.py (path:/tmp/pip-Dx_6Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:35 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)) 03:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:36 INFO - Running setup.py (path:/tmp/pip-QV3yRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:36 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)) 03:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:36 INFO - Running setup.py (path:/tmp/pip-uBp7tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 03:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:36 INFO - Running setup.py (path:/tmp/pip-eJpMGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:36 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)) 03:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:36 INFO - Running setup.py (path:/tmp/pip-B8nQH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:36 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)) 03:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:36 INFO - Running setup.py (path:/tmp/pip-Jf4hST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:36 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)) 03:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:36 INFO - Running setup.py (path:/tmp/pip-pyJWZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:36 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)) 03:19:36 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:36 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:36 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)) 03:19:36 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:36 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:36 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 03:19:36 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 03:19:36 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 03:19:36 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 03:19:36 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 03:19:36 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 03:19:38 INFO - Downloading blessings-1.6.tar.gz 03:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:38 INFO - Installing collected packages: blessings 03:19:38 INFO - Running setup.py install for blessings 03:19:38 INFO - Successfully installed blessings 03:19:38 INFO - Cleaning up... 03:19:38 INFO - Return code: 0 03:19:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:38 INFO - Reading from file tmpfile_stdout 03:19:38 INFO - Current package versions: 03:19:38 INFO - argparse == 1.2.1 03:19:38 INFO - blessings == 1.6 03:19:38 INFO - blobuploader == 1.2.4 03:19:38 INFO - docopt == 0.6.1 03:19:38 INFO - manifestparser == 1.1 03:19:38 INFO - mozInstall == 1.12 03:19:38 INFO - mozcrash == 0.17 03:19:38 INFO - mozdebug == 0.1 03:19:38 INFO - mozdevice == 0.48 03:19:38 INFO - mozfile == 1.2 03:19:38 INFO - mozhttpd == 0.7 03:19:38 INFO - mozinfo == 0.9 03:19:38 INFO - mozleak == 0.1 03:19:38 INFO - mozlog == 3.1 03:19:38 INFO - moznetwork == 0.27 03:19:38 INFO - mozprocess == 0.22 03:19:38 INFO - mozprofile == 0.28 03:19:38 INFO - mozrunner == 6.11 03:19:38 INFO - mozscreenshot == 0.1 03:19:38 INFO - mozsystemmonitor == 0.0 03:19:38 INFO - moztest == 0.7 03:19:38 INFO - mozversion == 1.4 03:19:38 INFO - psutil == 3.1.1 03:19:38 INFO - requests == 1.2.3 03:19:38 INFO - wsgiref == 0.1.2 03:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:38 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')]} 03:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:38 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')]} 03:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:38 INFO - Using env: {'DISPLAY': ':0', 03:19:38 INFO - 'HOME': '/home/cltbld', 03:19:38 INFO - 'LANG': 'en_US.UTF-8', 03:19:38 INFO - 'LANGUAGE': 'en_US:en', 03:19:38 INFO - 'LOGNAME': 'cltbld', 03:19:38 INFO - 'MAIL': '/var/mail/cltbld', 03:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:38 INFO - 'MOZ_NO_REMOTE': '1', 03:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:38 INFO - 'NO_EM_RESTART': '1', 03:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:38 INFO - 'PWD': '/builds/slave/test', 03:19:38 INFO - 'SHELL': '/bin/bash', 03:19:38 INFO - 'SHLVL': '1', 03:19:38 INFO - 'TERM': 'linux', 03:19:38 INFO - 'TMOUT': '86400', 03:19:38 INFO - 'USER': 'cltbld', 03:19:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:38 INFO - '_': '/tools/buildbot/bin/python'} 03:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:38 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 2)) 03:19:38 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 3)) 03:19:38 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 4)) 03:19:38 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 5)) 03:19:38 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 6)) 03:19:38 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 7)) 03:19:38 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 8)) 03:19:38 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 9)) 03:19:38 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:38 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 4)) 03:19:38 INFO - Cleaning up... 03:19:38 INFO - Return code: 0 03:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:38 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')]} 03:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:38 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')]} 03:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:38 INFO - Using env: {'DISPLAY': ':0', 03:19:38 INFO - 'HOME': '/home/cltbld', 03:19:38 INFO - 'LANG': 'en_US.UTF-8', 03:19:38 INFO - 'LANGUAGE': 'en_US:en', 03:19:38 INFO - 'LOGNAME': 'cltbld', 03:19:38 INFO - 'MAIL': '/var/mail/cltbld', 03:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:38 INFO - 'MOZ_NO_REMOTE': '1', 03:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:38 INFO - 'NO_EM_RESTART': '1', 03:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:38 INFO - 'PWD': '/builds/slave/test', 03:19:38 INFO - 'SHELL': '/bin/bash', 03:19:38 INFO - 'SHLVL': '1', 03:19:38 INFO - 'TERM': 'linux', 03:19:38 INFO - 'TMOUT': '86400', 03:19:38 INFO - 'USER': 'cltbld', 03:19:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:38 INFO - '_': '/tools/buildbot/bin/python'} 03:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:39 INFO - Downloading/unpacking jsonschema 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:41 INFO - Downloading/unpacking functools32 (from jsonschema) 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:41 INFO - warning: no files found matching '*.txt' 03:19:41 INFO - no previously-included directories found matching 'build' 03:19:41 INFO - no previously-included directories found matching 'dist' 03:19:41 INFO - no previously-included directories found matching '.git*' 03:19:41 INFO - Installing collected packages: jsonschema, functools32 03:19:41 INFO - Running setup.py install for functools32 03:19:41 INFO - warning: no files found matching '*.txt' 03:19:41 INFO - no previously-included directories found matching 'build' 03:19:41 INFO - no previously-included directories found matching 'dist' 03:19:41 INFO - no previously-included directories found matching '.git*' 03:19:41 INFO - Successfully installed jsonschema functools32 03:19:41 INFO - Cleaning up... 03:19:41 INFO - Return code: 0 03:19:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8563ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, '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': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', '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 03:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:19:41 INFO - Using env: {'DISPLAY': ':0', 03:19:41 INFO - 'HOME': '/home/cltbld', 03:19:41 INFO - 'LANG': 'en_US.UTF-8', 03:19:41 INFO - 'LANGUAGE': 'en_US:en', 03:19:41 INFO - 'LOGNAME': 'cltbld', 03:19:41 INFO - 'MAIL': '/var/mail/cltbld', 03:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:41 INFO - 'MOZ_NO_REMOTE': '1', 03:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:41 INFO - 'NO_EM_RESTART': '1', 03:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:41 INFO - 'PWD': '/builds/slave/test', 03:19:41 INFO - 'SHELL': '/bin/bash', 03:19:41 INFO - 'SHLVL': '1', 03:19:41 INFO - 'TERM': 'linux', 03:19:41 INFO - 'TMOUT': '86400', 03:19:41 INFO - 'USER': 'cltbld', 03:19:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:41 INFO - '_': '/tools/buildbot/bin/python'} 03:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:41 INFO - Downloading/unpacking flake8 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:19:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:19:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:43 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 03:19:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:19:44 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 03:19:44 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 03:19:44 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 03:19:44 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 03:19:44 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 03:19:44 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 03:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:19:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:44 INFO - no previously-included directories found matching 'docs/_build' 03:19:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:19:44 INFO - Running setup.py install for pep8 03:19:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:44 INFO - no previously-included directories found matching 'docs/_build' 03:19:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:19:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:19:44 INFO - Cleaning up... 03:19:44 INFO - Return code: 0 03:19:44 INFO - Running post-action listener: _resource_record_post_action 03:19:44 INFO - Running post-action listener: _start_resource_monitoring 03:19:44 INFO - Starting resource monitoring. 03:19:44 INFO - ##### 03:19:44 INFO - ##### Running install step. 03:19:44 INFO - ##### 03:19:44 INFO - Running pre-action listener: _resource_record_pre_action 03:19:44 INFO - Running main action method: install 03:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:44 INFO - Reading from file tmpfile_stdout 03:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:44 INFO - Reading from file tmpfile_stdout 03:19:44 INFO - Output received: 03:19:44 INFO - Usage: mozinstall [options] installer 03:19:44 INFO - Options: 03:19:44 INFO - -h, --help show this help message and exit 03:19:44 INFO - -d DEST, --destination=DEST 03:19:44 INFO - Directory to install application into. [default: 03:19:44 INFO - "/builds/slave/test"] 03:19:44 INFO - --app=APP Application being installed. [default: firefox] 03:19:44 INFO - mkdir: /builds/slave/test/build/application 03:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:20:00 INFO - Reading from file tmpfile_stdout 03:20:00 INFO - Output received: 03:20:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:00 INFO - Running post-action listener: _resource_record_post_action 03:20:00 INFO - ##### 03:20:00 INFO - ##### Running run-tests step. 03:20:00 INFO - ##### 03:20:00 INFO - Running pre-action listener: _resource_record_pre_action 03:20:00 INFO - Running main action method: run_tests 03:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:00 INFO - Python 2.7.3 03:20:00 INFO - Return code: 0 03:20:00 INFO - grabbing minidump binary from tooltool 03:20: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')]} 03:20:00 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 0x1cc8640>, '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 0x1cc9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc99d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:00 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 03:20:00 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 03:20:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:00 INFO - Return code: 0 03:20:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:20:01 INFO - Return code: 0 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:20:01 INFO - Using env: {'DISPLAY': ':0', 03:20:01 INFO - 'HOME': '/home/cltbld', 03:20:01 INFO - 'LANG': 'en_US.UTF-8', 03:20:01 INFO - 'LANGUAGE': 'en_US:en', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MAIL': '/var/mail/cltbld', 03:20:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SHLVL': '1', 03:20:01 INFO - 'TERM': 'linux', 03:20:01 INFO - 'TMOUT': '86400', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - '_': '/tools/buildbot/bin/python'} 03:20:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:20:01 INFO - mozversion application_buildid: 20160504020551 03:20:01 INFO - mozversion application_changeset: e02797aae3cea963d11f2bffefe397b1f3159554 03:20:01 INFO - mozversion application_display_name: Nightly 03:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:01 INFO - mozversion application_name: Firefox 03:20:01 INFO - mozversion application_remotingname: firefox 03:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:20:01 INFO - mozversion application_vendor: Mozilla 03:20:01 INFO - mozversion application_version: 49.0a1 03:20:01 INFO - mozversion platform_buildid: 20160504020551 03:20:01 INFO - mozversion platform_changeset: e02797aae3cea963d11f2bffefe397b1f3159554 03:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:20:01 INFO - mozversion platform_version: 49.0a1 03:20:01 INFO - using testdate: 1462357201 03:20:01 INFO - actual date: 1462357201 03:20:01 INFO - starting webserver on 'localhost:41565' 03:20:01 INFO - SUITE-START | Running 2 tests 03:20:01 INFO - TEST-START | dromaeo_css 03:20:01 INFO - operating with platform_type : linux_ 03:20:01 INFO - Initialising browser for dromaeo_css test... 03:20:01 INFO - TEST-INFO | started process 16211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM8qfaw/profile http://localhost:41565/getInfo.html) 03:20:05 INFO - PROCESS | 16211 | 03:20:05 INFO - PROCESS | 16211 | (process:16279): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:20:06 INFO - PROCESS | 16211 | __metrics Screen width/height:1600/1200 03:20:06 INFO - PROCESS | 16211 | colorDepth:24 03:20:06 INFO - PROCESS | 16211 | Browser inner width/height: 1024/697 03:20:06 INFO - PROCESS | 16211 | __metrics 03:20:06 ERROR - PROCESS | 16211 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:20:07 INFO - TEST-INFO | 16211: exit 0 03:20:07 INFO - Browser initialized. 03:20:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:07 INFO - TEST-INFO | started process 16330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM8qfaw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:09 INFO - PROCESS | 16330 | 03:20:09 INFO - PROCESS | 16330 | (process:16389): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:20:19 INFO - PROCESS | 16330 | RSS: Main: 165933056 03:20:19 INFO - PROCESS | 16330 | 03:21:09 INFO - PROCESS | 16330 | 1462357269259 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] 03:23:20 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41565/tests/dromaeo/cssquery-ext.html) 03:23:21 INFO - PROCESS | 16330 | RSS: Main: 170840064 03:23:21 INFO - PROCESS | 16330 | 03:26:23 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-ext.html (next: http://localhost:41565/tests/dromaeo/cssquery-jquery.html) 03:26:24 INFO - PROCESS | 16330 | RSS: Main: 168062976 03:26:24 INFO - PROCESS | 16330 | 03:29:26 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41565/tests/dromaeo/cssquery-mootools.html) 03:29:26 INFO - PROCESS | 16330 | RSS: Main: 168640512 03:29:26 INFO - PROCESS | 16330 | 03:32:28 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41565/tests/dromaeo/cssquery-prototype.html) 03:32:29 INFO - PROCESS | 16330 | RSS: Main: 166617088 03:32:29 INFO - PROCESS | 16330 | 03:35:31 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41565/tests/dromaeo/cssquery-yui.html) 03:35:32 INFO - PROCESS | 16330 | RSS: Main: 168067072 03:35:32 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | Cycle 1(1): loaded http://localhost:41565/tests/dromaeo/cssquery-yui.html (next: http://localhost:41565/tests/dromaeo/cssquery-dojo.html) 03:38:35 INFO - PROCESS | 16330 | RSS: Main: 169607168 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | __start_tp_report 03:38:35 INFO - PROCESS | 16330 | _x_x_mozilla_page_load 03:38:35 INFO - PROCESS | 16330 | _x_x_mozilla_page_load_details 03:38:35 INFO - PROCESS | 16330 | |i|pagename|runs| 03:38:35 INFO - PROCESS | 16330 | |0;dojo.html;2640.3267166872447;2677.8259413138144;2710.4443589064244;2710.8614381959574;2714.5113879501682;4692.835750748724;4694.319323698066;4718.292256161569;4726.102040612285;4752.120857641339;4586.289125185602;4671.789769460374;4710.623150147989;4757.8096876125;4768.1894078006735;4288.892777680559;4338.761368124752;4369.584889435499;4377.781110944456;4418.403515525411;4354.390385346038;4365.126974605076;4377.956220437803;4379.802908869093;4419.4033805436175;4259.850905218303;4262.041040765834;4328.718633288826;4352.325389564607;4402.3836662867225;4293.763842988635;4321.524632290446;4335.436393268855;4343.500497442771;4383.408239887638;4230.619244267999;4256.170046840867;4258.54905720678;4263.765492897889;4310.48274207094;4456.064226512436;4523.050159466516;4563.041761230145;4569.95430045702;4596.057808149321;4952.0838644850455;4956.553910148068;4961.82633607822;4974.079795237856;5011.223260394645;4800.207965685658;5004.749762511896;5021.472745361721;5046.520580544842;5085;4678.602318802906;4696.835610753607;4700.952990470051;4734.3371927929775;4751.596114330251;5127.307813445212;5169.793208271627;5175.042617115846;5180.611454140954;5206.140986737146;4785.210440277385;4961.702297862068;4965.726885021359;4972.8508144755715;5024.62315326352;4954.108260513142;4964.975175124101;5004.824831130893;5025.623078269145;5046.646734728533;4896.314515967767;4930.852074437773;5006.799728010911;5019.146745053276;5053.2420136979745;4912.9508704913205;4936.975315123402;4961.950380496221;4967.081089998362;4992.625553083533;4321.762303073298;4350.369196466558;4361.5856493633055;4377.387165796791;4387.934180987288;3731.6081811409954;3751.1372384351753;3756.1924186300075;3777.8488860445823;3779.3952967525065;4272.316429371348;4308.569143085666;4348.9565104349185;4376.234159022159;4412.183746006999;5082.491750824888;5084.034033533617;5084.186530155157;5090.974545127251;5107.61692873036;4351.782410879443;4372.300431930939;4372.956270437255;4389.604935555815;4425.203463376559;4470.843520476833;4504.932426013613;4508.977455112704;4572.7713614319155;4589.151007063704;4764.118638051971;4768.999999999931;4779.187538118528;4796.088743138793;4800.759962001886;5064.645474816874;5069.898602028013;5071.239314102914;5074.6194035448225;5089.083964886356;4650.767461626838;4658.510856360033;4722.173619616485;4735.857924262277;4787.066522028171;4982.053409852117;4982.377202849644;5007.273945277841;5013.147764879906;5052.9494705052475;5073.315102461121;5077.593792496666;5079.111155547838;5082.364704411949;5131.87170320745;4785.641076919175;4807.375041244616;4839.95160048395;4876.853694389174;4900.632452566;4775.904481910273;4855.150348689036;4856.805727770991;4863.367762190893;4915.311856340187;4809.134355815847;4851.345068415719;4853.49038350968;4860.513948605111;4884.92672609904;4805.063012712627;4851.029794041277;4935.555799978019;4960.206366981266;4980.452150263396;4807.879803004953;4818.903621927471;4819.662623616313;4837.105135549935;4877.512248775094 03:38:35 INFO - PROCESS | 16330 | |1;ext.html;586.7447660267784;607.893618616742;614.6680792372119;631.3055638797322;637.6014990630856;34594.13514662132;35482;35604.82197589015;35606.643933560656;35919.82040089799;35376.823115884385;36031.459528107036;36052;36061.81969090151;36092.278154436965;7396.70413183472;7565.962170189141;7571.356434703057;7616.504927179715;7636.312731854132;7668.731594394198;7765.728199513018;7816.218378162167;7823.569703666296;7831.216878312181;7725.266099720546;7801.882971755428;7821.921780782205;7827.295543401093;7854.332381747558;7712.884306735404;7736.110347310075;7785.299323060952;7826.452148349618;7827.765167044998;7580.1661817200065;7699.4995325304235;7734.729284475016;7736.7292144774665;7740.458167928247;25891.74108258912;35900.82049589735;36355.27289454223;36476.088097797765;36682;2951.199733337315;2973.3458639099363;3110.3623757129963;3166.794158379721;3173.1908363367424;26937.86531067352;27974.160775176777;28330.85834570814;28409.715902840915;29131.41737165266;3389.661033896615;3450.9058132509354;3470.6529347065343;3497.440409534462;3593.0658028912408;102598.48700756449;103067.48466257696;104201;104478.47760761224;104752;58144.709276453345;58996.41003589995;59153;59212;59555;54381;55222.85828562793;55326.72336638291;55425.168622470694;62865.37134628687;14032.228227447384;14294.571162865132;14361.138331700131;14425.278736063365;14428.85571144296;10815.080718139046;11025.889741102486;11047.226694131334;11057.336559806437;11087.168462365193;19096.140673669717;19154.233830646896;19184.232630694616;19188.71216931747;19202.13590388436;7593;7650.579218143055;7653.617319134132;7676.155622881479;7712.344450721639;864.6282098697494;882.4925667741074;932.7901222224945;981.5779214937645;1053.6904062384883;26085.219241507733;26123.216303510926;26488.47023059528;26489.20532383993;26515.734842651713;972.7519482531909;980.6028558433845;988.6737376665683;1079.1636481726725;1079.5304042741432;14220.71558568823;14441.711165776625;14444.855551444562;14565.635859103608;14705.852941470663;358446;363953;366170;366362;366456;49457.752711236935;50463;50499.99000019979;50719;50813;1173.9514547115339;1229.6188181663713;1233.96915077122;1239.156136666353;1245.5391505143155;26240.475190496465;26837.194884153505;26926.192214233604;27511.86244068767;27569.172924812287;42917;43272;43277.56722432861;43560.56439435565;43733.125337492434;324762;326523;329273;329549;329936;25733.613995790452;26424.735752642227;35440.64559354373;36469.45295820618;36480;38197.427038595;38212.23575528529;38706.80646596749;38867.222655547295;39196.41205381979;33253.667463326026;34178.48732269068;35935.82032089823;36074;36232.27535449224;35125.473117902744;35167.47248791219;35368.46947295741;35407;35882.10294742652;34947.30105397827;35044.82477587596;35626.643733562334;36185.45721814228;36289.09277267984;30922.226944325674;31904;32054.19864503406;32249.35501289914;32288.83855580707;24946.750532494443;24997.500049998533;25141.120060797784;25251.11621093253;25636.743632563437 03:38:35 INFO - PROCESS | 16330 | |2;jquery.html;377.7299231049799;383.10544877710544;383.99040023999396;384.66149788186397;389.0759446315002;15687;16151.515454536368;16940.83059169408;16963.406280780175;16972.405965791186;14127.505537306197;16138.354465821352;16577;16614.916925415386;16684.165791710395;4541.386912766776;4670.1126785910565;4701.294805779144;4708.19960606696;4710.905781884378;3336.9332613347838;4958.6281028922795;5239.79040838366;5259.0796610593;5259.76331065103;5221.138512145491;5236.842894713165;5240.60695447841;5246.895062098756;5257.5005374489365;5343.7328133593355;5850.736716847752;5895.64626122434;5918.556108291874;5920.644761314314;4750.239961606127;5244.108501554745;5274.077036518594;5274.604404669627;5284.154535274338;11882.881171188264;12088.395580221042;12119.93940030303;12205.877941220651;12212.755744885142;1874.287770647159;1917.1947781931622;1924.2399252295404;1925.2491528303972;2363.1610778173845;8485.83028339436;8559.657613695445;8745.387822852403;8787.121287871161;8921.107889211093;1682.2177687375429;1696.177353983317;1715.536017783364;1723.7069698151345;1809.7737782777153;66541;69266;69578;70107.64946175288;71118.28881711168;8968.68609598661;9151.679691210775;9845.261605379483;10171.796564068678;10666.546694260363;13663.043586949017;13691;13712;13722;13759.17444953306;6885.690143943534;7003.299670032956;7069.787906362817;7099.858002839915;7147.785566433015;6553.770618028346;6567.376099270562;6598.241202261705;6858.129002653528;6887.621180835002;4046.8178931947546;4063.553009168989;4167.749935003849;4292.141571685675;4409.184300904343;1720.8623310135158;1797.6764182447023;1832.2121487760392;1874.6625607390529;1908.7900330963582;863.5509535041743;916.9358144929924;925.3337596930199;949.0367277213634;952.994590706811;15318.846811531965;15672.686546269011;15885.920570397306;16029.19854007295;16109;856.1609622569916;882.0517943211074;889.3147485514913;933.2160984772823;948.814981078683;9212.769680757901;9247.537623118817;9314;9563.330566860392;9684.70945871625;407055;408608;409518;414144;419350;76532;77421.61289193518;78750.60624696955;79277.60361198272;79456;933.7945651956694;949.1505102932974;969.6024629901707;979.490664854286;993.0913214408735;14802.779583062627;15040.774388384401;15079.849201508283;15185.088894666356;15460.690786184437;34360.312793743484;34770.130746731535;35106.473402899486;35501.28997420089;35874.46188307125;48236.27645585389;48483.5151648479;49163;50433.24350134678;50462.49537504578;7306.3789577884345;7330.193678695233;7340;7369.742059028123;7544.245575442631;9797;10606.575736970743;11008.339499630049;11067;11304;9311.953440233026;9434.150926416381;9580.041995800364;9740.659076932274;9883;9362.906370936204;9810.901890980998;9971.152452041657;10020.849687254551;10251.436171010666;9585.424874507273;9833.852492212765;9899.307048506535;10011.299209055296;10106.848397274194;7442.665080071301;7460.776176714708;7479.364254038468;7557.2820582044615;7581.128170260491;8712.520811355436;10207.795844083224;10370.533326000499;10404.375737455777;10816.56733730642 03:38:35 INFO - PROCESS | 16330 | |3;mootools.html;1429.4210844607935;1431.8568143185682;1510.6525499135198;1616.9272382742774;1619.0852168524775;6257.624542527452;6779.830504237397;6924.20371657259;7225.5664660120365;7226.313500217471;6661.300563440842;6666.366695163963;6726.6300353480665;6754.290799466059;6785.219699734532;2082.7084208210827;2140.871547707143;2141.4004078857943;2143.228437762404;2148.98925505373;2050.8872012039333;2099.653557163066;2102.55846272283;2118.184498967893;2127.702121702963;2059.3204242599904;2079.1475495047034;2091.2785089144295;2100.2019232691555;2103.663413853784;2062.4328309714797;2065.8863762493056;2069.079259729421;2074.958500829975;2083.135498768017;1999.5001249687577;2019.6162729081575;2025.1494372363643;2037.7350944377135;2048.2319130326127;6912.585244885273;6916.3429474199875;6925.342092501204;6952.826179345506;6954.3045695430055;4226.175895700339;4350.956490435086;4376.8686939391555;4381.737095774264;4383.890402739957;2663.7735792457665;2802.453521563296;2821.50623640862;2822.50606143924;2836;952.1716106986966;957.0477375011839;962.138885697304;973.6446197137993;988.5057471264367;9431.952840235823;9447.866256049318;9485.051494850528;9485.193758530533;9510.28672849532;3883.475730776309;3952.2095580883365;3974.7615143091507;4048.4129801178665;4050.716449848482;8303.501789892625;8332.125126861714;8351.1648835116;8355.665773369119;8374.49753014821;4327.740335579875;4350;4356;4366.956330436718;4367.912641747147;3493.0219538529254;3896.2207558488417;3986.22268657609;4018.8794336169963;4054.087830238173;3353.748468864845;3403.608585012755;3428.5371474850576;3434.1242983039165;3523.083998160497;1112.694009147491;1152.6196355202762;1152.7002979225463;1153.2561497834017;1167.8088349883071;814.9388795840217;865.1348651348651;868.7654333329965;906.6237511432813;908.5911339897073;5150.690958542425;5167.715775632301;5222.686638801684;5223.451537588575;5348.171033489815;888.8666699995052;907.4782000349825;921.8663293822358;935.9812803743887;949.2832911152036;3452.775569588019;3460.1522626956557;3490.877819276313;3538.5399898013093;3557.9288414232087;8194.836103277901;8476.152384761597;8568.785780355542;8573.828523429496;8575.828483430296;8378.916210837935;8468.703595374132;8559.058503564604;8560.272376847914;8569.528675922884;6677.09859169006;6747.763828265987;6873.828154296182;6874.484413668994;6891.310868913069;4922.335484709519;4936.555709986119;5029.189491782882;5042.621803364689;5087.160618497906;8124.22819832115;8155.959220203861;8164.83670326602;8188.50868947865;8225.71210007647;7689.423293252917;7997.480163789335;8002.759917202493;8070.071941726542;8301.792455188668;5735.197072409783;6076.817695469143;6273.121762953099;6274.686265686789;6420.935790642221;6600;6606;6637.137172167587;6665.900011499734;6719.832004199934;6123.234595675541;6325.177726895474;6387.137736405712;6431.260405053292;6432.742690292336;6088.6042407243385;6108.877822443437;6190.380961903774;6223.813285601439;6258;5876.500497457764;5918.644881307136;5952.761889524544;5987.491063259672;6007.219061521974;4398.538153493965;4484.9103017940115;4504.819807207675;4531.524189960139;4598.770061496845;4361.411209486679;4457.888552786207;4501.18978583858;4543.204939135572;4583.656225783013 03:38:35 INFO - PROCESS | 16330 | |4;prototype.html;292.85796388751453;298.1027108403705;302.6821837071075;303.5643851073709;310.1950438611802;4695.67130300879;4811.615070794337;4824.107540105074;4938.580220681242;4941.87645308867;4870.512948705128;4877.8781230164905;4903.754812259391;4908.165611845986;4913.3612630358;3812.1613245086105;3827.349350610389;3840.327942610046;3849.3840985442334;3869.632384923442;3774.4338349247696;3859.6912247020173;3860.7645553422917;3865.3042452358563;3879.941800872975;3779.1496913194587;3797.3924172132465;3805.562360328556;3830.291396091732;3841.8463261469506;3785.5268091488565;3794.658480736733;3807.8857634270876;3823.6941044716355;3852.460655508231;3395.7266025240533;3406.7785593936314;3435.57055368079;3438.277961628061;3445.552078229814;4416.712913660602;4693.718376897363;4723.692959957626;4732.337472753818;4743.268706921948;4260.318349064166;4297.67767417445;4297.8495752648505;4325.221460137174;4335.653147748172;5122.615803814691;5124.205748109049;5146.665466744649;5173.560247378978;5173.81891633791;3562.536870206882;3643.708503319728;3648.1426864686778;3662.61542538035;3670.4127339625798;5207.401148867891;5335.1997200419855;5359.437259087778;5367.919481207785;5422.539084177889;3692.833822477995;3712.480252764615;3726.888193354204;3734.607866174067;3741.56971948224;3764.322421964018;3768.6231376862643;3782.394816829294;3783.9432408513894;3784.2242340320167;4041.393790931325;4296.591823776799;4304.5910638489295;4306.80619372129;4345.3699213613845;5074.517920797518;5107.284980102789;5123.923141152885;5136.049830781318;5138.203578445347;1282.7819270723999;1320.9801852972214;1362.5503583817317;1365.0308281120515;1366.9931650341684;890.2922176869405;900.4012331799411;903.1239697493421;903.3468752183488;910.1490106750077;4701.294805779161;4707.95292047082;4726.952730472652;4733.715977041388;4741.9051618968115;5514.6691198528215;5527.613067085265;5548.86127846799;5583.292103329882;5594.440555944454;4583.129205450954;4705.247160454311;4708.411448568929;4719.480857105716;4724.149653062482;2948.4545359108633;2953.3354995126356;2962.126172779035;2965.273507990556;2973.8215707057648;5184.870378240575;5193.246979187997;5229.973850130801;5257.63196576236;5267.841964741064;5497.285352904177;5651.434856514398;5657.660540367591;5679.148127780783;5738.311402631711;5254.6847189168775;5263.526282634582;5269.104252277122;5272.657277277041;5281.683099013994;5483.479069488392;5536.44979405767;5566.24855644499;5591.077472217039;5593.244911936837;5342.78628854857;5417.485338892799;5424.267723857229;5439.096316289267;5442.619016668954;5192.870178245574;5205.308274810777;5209.973950130377;5239.109351410346;5263.763130659206;3857.61423857612;3862.1889403225637;3872.96127038726;3879.6809084910137;3885.553161386477;4986.47641997585;5334.333208348957;5540.501354878081;5564.10974244119;5577.27495425592;5024.598032157345;5115.820946266863;5171.3535808024;5185.429602743619;5189.740512974412;5149.510796474329;5163.66436181647;5176.611754118381;5177.4822517747925;5190.8961820762615;4886.462489126265;5068.82259120929;5094.439611642642;5095.414027386898;5096.0827051131155;5186.766595503136;5197.532222100029;5229.450907654794;5245.816396426107;5265.7367131642495;5120.48795120485;5129.640925135354;5131.384233891957;5141.691498510101;5149.48090313351 03:38:35 INFO - PROCESS | 16330 | |5;yui.html;665.7869481765835;681.3901558105495;751.5378042503859;762.626313106578;776.7436745873858;12126.636200913976;12538.122331436804;12538.185017973825;12552.560660376888;12562;11546.769064618702;11623.709407264823;11624.883751162486;11692.947634712875;11738.178327517076;612.1735656863243;785.2540086917422;797.4417907464768;798.0184373220912;798.3294033012269;780.0950896959528;804.4489524675587;805.899262592176;806.9717559885405;810.6635746165334;841.2134654098408;847.7795773098977;848.0544193224541;854.6239654551978;854.9102344253857;836.4688422851502;843.5149788871393;845.6701886264361;847.1486156412766;849.6771226933787;615.6306216270247;620.2928661326092;624.6782906803;626.3673689573518;627.3005598757353;12195.878041219563;12238.204516706475;12249.632511024594;12271.815922761076;12307.876921230853;12530.561430349893;12596.307203103826;12679.429425675868;12892.41984110708;13245.07284490086;9657;9727.270454715925;9866.112049915542;9919.404835709809;10064.446455444948;3273;3280.2783387654677;3285.1951271938287;3329.3674201901563;3397.1167496450853;40255;40849.79575102135;41475.377869331984;41480;41492.28661980988;9778.65774697882;9846;9864.753381165528;9963.153131983718;10096.747581310527;16060;16155.757663635055;16163.515094546947;16184.919075404783;16417.753733694004;6564.540482166202;6580.605163690194;6625.834354141089;6722;6829.590224586541;3604.85580576774;3730.421784623388;3730.6828919542145;3774.169682669808;3793.1275806564645;2665.120510231619;2764.3918337965615;2766.2531116598407;3054.480738274499;3178.364327134536;517.3068088761078;528.118042868403;531.6836482293029;531.8377894742064;536.0378121272248;585.5140233606097;588.069041090451;595.3034949109552;595.382806336855;619.2723549828933;7778.961105194438;7813.492123011986;7848.372130229568;7960.2039796019935;8048.315893149031;499.61030396290954;582.3797655496883;598.5211830535554;609.3601718195877;614.7940439952577;3161.0200837740376;3176.3647270545985;3216.3728073025536;3322.983385083059;3721.5348081489815;55436.44563554393;57307.426925731044;57360.13959790606;57644.71177644085;57736.71131644399;44279;49775.75112124416;51709.63887347386;52770.20844687256;52774.20838687423;41217.79391103085;41520.58479415227;41607.37588936168;41657.37513937233;41994.790026049675;7984.600769961595;7995.760127196193;8092.190780921861;8154.551499667576;8188.5905704715715;29898.551521727626;30112.54831177578;30497.847510763193;30601.23496912595;30710.078697639106;37091.44362834613;38907.80546097364;39619.405708913815;39842.60157398505;40014.599854001084;10591.042034758006;10691.839622405514;10811.081058109834;10916.78166436651;10947.45262736844;11421.942890285827;11545.88454115448;11683.299002059903;11793.705157371134;11884.34636095023;11293.774124517628;11313.886861131283;11455;11722;11913.285202887855;10436.63471778484;11637.650870473899;11689.473973671375;11743.177977541833;11744.29534227949;11185.608503702331;11224.887751122711;11249.325040497597;11289.435528223721;11414.14393920476;9701.6604418845;9909.504524773589;9958.253131015057;10204.846927296245;10405.115565177044;9748.707538773848;10092.14216791581;10132.34139780912;10156.18750499973;10156.796864062826 03:38:35 INFO - PROCESS | 16330 | __end_tp_report 03:38:35 INFO - PROCESS | 16330 | __start_cc_report 03:38:35 INFO - PROCESS | 16330 | _x_x_mozilla_cycle_collect,382 03:38:35 INFO - PROCESS | 16330 | __end_cc_report 03:38:35 INFO - PROCESS | 16330 | __startTimestamp1462358315369__endTimestamp 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | ------- Summary: start ------- 03:38:35 INFO - PROCESS | 16330 | Number of tests: 6 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#0] dojo.html Cycles:165 Average:4649.81 Median:4779.19 stddev:472.58 (9.9%) stddev-sans-first:446.97 03:38:35 INFO - PROCESS | 16330 | Values: 2640.3 2677.8 2710.4 2710.9 2714.5 4692.8 4694.3 4718.3 4726.1 4752.1 4586.3 4671.8 4710.6 4757.8 4768.2 4288.9 4338.8 4369.6 4377.8 4418.4 4354.4 4365.1 4378.0 4379.8 4419.4 4259.9 4262.0 4328.7 4352.3 4402.4 4293.8 4321.5 4335.4 4343.5 4383.4 4230.6 4256.2 4258.5 4263.8 4310.5 4456.1 4523.1 4563.0 4570.0 4596.1 4952.1 4956.6 4961.8 4974.1 5011.2 4800.2 5004.7 5021.5 5046.5 5085.0 4678.6 4696.8 4701.0 4734.3 4751.6 5127.3 5169.8 5175.0 5180.6 5206.1 4785.2 4961.7 4965.7 4972.9 5024.6 4954.1 4965.0 5004.8 5025.6 5046.6 4896.3 4930.9 5006.8 5019.1 5053.2 4913.0 4937.0 4962.0 4967.1 4992.6 4321.8 4350.4 4361.6 4377.4 4387.9 3731.6 3751.1 3756.2 3777.8 3779.4 4272.3 4308.6 4349.0 4376.2 4412.2 5082.5 5084.0 5084.2 5091.0 5107.6 4351.8 4372.3 4373.0 4389.6 4425.2 4470.8 4504.9 4509.0 4572.8 4589.2 4764.1 4769.0 4779.2 4796.1 4800.8 5064.6 5069.9 5071.2 5074.6 5089.1 4650.8 4658.5 4722.2 4735.9 4787.1 4982.1 4982.4 5007.3 5013.1 5052.9 5073.3 5077.6 5079.1 5082.4 5131.9 4785.6 4807.4 4840.0 4876.9 4900.6 4775.9 4855.2 4856.8 4863.4 4915.3 4809.1 4851.3 4853.5 4860.5 4884.9 4805.1 4851.0 4935.6 4960.2 4980.5 4807.9 4818.9 4819.7 4837.1 4877.5 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#1] ext.html Cycles:180 Average:42839.00 Median:197164.05 stddev:76831.81 (39.0%) stddev-sans-first:76981.85 03:38:35 INFO - PROCESS | 16330 | Values: 586.7 607.9 614.7 631.3 637.6 34594.1 35482.0 35604.8 35606.6 35919.8 35376.8 36031.5 36052.0 36061.8 36092.3 7396.7 7566.0 7571.4 7616.5 7636.3 7668.7 7765.7 7816.2 7823.6 7831.2 7725.3 7801.9 7821.9 7827.3 7854.3 7712.9 7736.1 7785.3 7826.5 7827.8 7580.2 7699.5 7734.7 7736.7 7740.5 25891.7 35900.8 36355.3 36476.1 36682.0 2951.2 2973.3 3110.4 3166.8 3173.2 26937.9 27974.2 28330.9 28409.7 29131.4 3389.7 3450.9 3470.7 3497.4 3593.1 102598.5 103067.5 104201.0 104478.5 104752.0 58144.7 58996.4 59153.0 59212.0 59555.0 54381.0 55222.9 55326.7 55425.2 62865.4 14032.2 14294.6 14361.1 14425.3 14428.9 10815.1 11025.9 11047.2 11057.3 11087.2 19096.1 19154.2 19184.2 19188.7 19202.1 7593.0 7650.6 7653.6 7676.2 7712.3 864.6 882.5 932.8 981.6 1053.7 26085.2 26123.2 26488.5 26489.2 26515.7 972.8 980.6 988.7 1079.2 1079.5 14220.7 14441.7 14444.9 14565.6 14705.9 358446.0 363953.0 366170.0 366362.0 366456.0 49457.8 50463.0 50500.0 50719.0 50813.0 1174.0 1229.6 1234.0 1239.2 1245.5 26240.5 26837.2 26926.2 27511.9 27569.2 42917.0 43272.0 43277.6 43560.6 43733.1 324762.0 326523.0 329273.0 329549.0 329936.0 25733.6 26424.7 35440.6 36469.5 36480.0 38197.4 38212.2 38706.8 38867.2 39196.4 33253.7 34178.5 35935.8 36074.0 36232.3 35125.5 35167.5 35368.5 35407.0 35882.1 34947.3 35044.8 35626.6 36185.5 36289.1 30922.2 31904.0 32054.2 32249.4 32288.8 24946.8 24997.5 25141.1 25251.1 25636.7 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#2] jquery.html Cycles:180 Average:24400.41 Median:50447.87 stddev:67930.42 (134.7%) stddev-sans-first:68097.03 03:38:35 INFO - PROCESS | 16330 | Values: 377.7 383.1 384.0 384.7 389.1 15687.0 16151.5 16940.8 16963.4 16972.4 14127.5 16138.4 16577.0 16614.9 16684.2 4541.4 4670.1 4701.3 4708.2 4710.9 3336.9 4958.6 5239.8 5259.1 5259.8 5221.1 5236.8 5240.6 5246.9 5257.5 5343.7 5850.7 5895.6 5918.6 5920.6 4750.2 5244.1 5274.1 5274.6 5284.2 11882.9 12088.4 12119.9 12205.9 12212.8 1874.3 1917.2 1924.2 1925.2 2363.2 8485.8 8559.7 8745.4 8787.1 8921.1 1682.2 1696.2 1715.5 1723.7 1809.8 66541.0 69266.0 69578.0 70107.6 71118.3 8968.7 9151.7 9845.3 10171.8 10666.5 13663.0 13691.0 13712.0 13722.0 13759.2 6885.7 7003.3 7069.8 7099.9 7147.8 6553.8 6567.4 6598.2 6858.1 6887.6 4046.8 4063.6 4167.7 4292.1 4409.2 1720.9 1797.7 1832.2 1874.7 1908.8 863.6 916.9 925.3 949.0 953.0 15318.8 15672.7 15885.9 16029.2 16109.0 856.2 882.1 889.3 933.2 948.8 9212.8 9247.5 9314.0 9563.3 9684.7 407055.0 408608.0 409518.0 414144.0 419350.0 76532.0 77421.6 78750.6 79277.6 79456.0 933.8 949.2 969.6 979.5 993.1 14802.8 15040.8 15079.8 15185.1 15460.7 34360.3 34770.1 35106.5 35501.3 35874.5 48236.3 48483.5 49163.0 50433.2 50462.5 7306.4 7330.2 7340.0 7369.7 7544.2 9797.0 10606.6 11008.3 11067.0 11304.0 9312.0 9434.2 9580.0 9740.7 9883.0 9362.9 9810.9 9971.2 10020.8 10251.4 9585.4 9833.9 9899.3 10011.3 10106.8 7442.7 7460.8 7479.4 7557.3 7581.1 8712.5 10207.8 10370.5 10404.4 10816.6 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#3] mootools.html Cycles:180 Average:4748.53 Median:5805.85 stddev:2518.94 (43.4%) stddev-sans-first:2513.66 03:38:35 INFO - PROCESS | 16330 | Values: 1429.4 1431.9 1510.7 1616.9 1619.1 6257.6 6779.8 6924.2 7225.6 7226.3 6661.3 6666.4 6726.6 6754.3 6785.2 2082.7 2140.9 2141.4 2143.2 2149.0 2050.9 2099.7 2102.6 2118.2 2127.7 2059.3 2079.1 2091.3 2100.2 2103.7 2062.4 2065.9 2069.1 2075.0 2083.1 1999.5 2019.6 2025.1 2037.7 2048.2 6912.6 6916.3 6925.3 6952.8 6954.3 4226.2 4351.0 4376.9 4381.7 4383.9 2663.8 2802.5 2821.5 2822.5 2836.0 952.2 957.0 962.1 973.6 988.5 9432.0 9447.9 9485.1 9485.2 9510.3 3883.5 3952.2 3974.8 4048.4 4050.7 8303.5 8332.1 8351.2 8355.7 8374.5 4327.7 4350.0 4356.0 4367.0 4367.9 3493.0 3896.2 3986.2 4018.9 4054.1 3353.7 3403.6 3428.5 3434.1 3523.1 1112.7 1152.6 1152.7 1153.3 1167.8 814.9 865.1 868.8 906.6 908.6 5150.7 5167.7 5222.7 5223.5 5348.2 888.9 907.5 921.9 936.0 949.3 3452.8 3460.2 3490.9 3538.5 3557.9 8194.8 8476.2 8568.8 8573.8 8575.8 8378.9 8468.7 8559.1 8560.3 8569.5 6677.1 6747.8 6873.8 6874.5 6891.3 4922.3 4936.6 5029.2 5042.6 5087.2 8124.2 8156.0 8164.8 8188.5 8225.7 7689.4 7997.5 8002.8 8070.1 8301.8 5735.2 6076.8 6273.1 6274.7 6420.9 6600.0 6606.0 6637.1 6665.9 6719.8 6123.2 6325.2 6387.1 6431.3 6432.7 6088.6 6108.9 6190.4 6223.8 6258.0 5876.5 5918.6 5952.8 5987.5 6007.2 4398.5 4484.9 4504.8 4531.5 4598.8 4361.4 4457.9 4501.2 4543.2 4583.7 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#4] prototype.html Cycles:180 Average:4339.49 Median:4895.11 stddev:1275.62 (26.1%) stddev-sans-first:1242.51 03:38:35 INFO - PROCESS | 16330 | Values: 292.9 298.1 302.7 303.6 310.2 4695.7 4811.6 4824.1 4938.6 4941.9 4870.5 4877.9 4903.8 4908.2 4913.4 3812.2 3827.3 3840.3 3849.4 3869.6 3774.4 3859.7 3860.8 3865.3 3879.9 3779.1 3797.4 3805.6 3830.3 3841.8 3785.5 3794.7 3807.9 3823.7 3852.5 3395.7 3406.8 3435.6 3438.3 3445.6 4416.7 4693.7 4723.7 4732.3 4743.3 4260.3 4297.7 4297.8 4325.2 4335.7 5122.6 5124.2 5146.7 5173.6 5173.8 3562.5 3643.7 3648.1 3662.6 3670.4 5207.4 5335.2 5359.4 5367.9 5422.5 3692.8 3712.5 3726.9 3734.6 3741.6 3764.3 3768.6 3782.4 3783.9 3784.2 4041.4 4296.6 4304.6 4306.8 4345.4 5074.5 5107.3 5123.9 5136.0 5138.2 1282.8 1321.0 1362.6 1365.0 1367.0 890.3 900.4 903.1 903.3 910.1 4701.3 4708.0 4727.0 4733.7 4741.9 5514.7 5527.6 5548.9 5583.3 5594.4 4583.1 4705.2 4708.4 4719.5 4724.1 2948.5 2953.3 2962.1 2965.3 2973.8 5184.9 5193.2 5230.0 5257.6 5267.8 5497.3 5651.4 5657.7 5679.1 5738.3 5254.7 5263.5 5269.1 5272.7 5281.7 5483.5 5536.4 5566.2 5591.1 5593.2 5342.8 5417.5 5424.3 5439.1 5442.6 5192.9 5205.3 5210.0 5239.1 5263.8 3857.6 3862.2 3873.0 3879.7 3885.6 4986.5 5334.3 5540.5 5564.1 5577.3 5024.6 5115.8 5171.4 5185.4 5189.7 5149.5 5163.7 5176.6 5177.5 5190.9 4886.5 5068.8 5094.4 5095.4 5096.1 5186.8 5197.5 5229.5 5245.8 5265.7 5120.5 5129.6 5131.4 5141.7 5149.5 03:38:35 INFO - PROCESS | 16330 | 03:38:35 INFO - PROCESS | 16330 | [#5] yui.html Cycles:180 Average:12878.83 Median:41346.59 stddev:14787.12 (35.8%) stddev-sans-first:14800.16 03:38:35 INFO - PROCESS | 16330 | Values: 665.8 681.4 751.5 762.6 776.7 12126.6 12538.1 12538.2 12552.6 12562.0 11546.8 11623.7 11624.9 11692.9 11738.2 612.2 785.3 797.4 798.0 798.3 780.1 804.4 805.9 807.0 810.7 841.2 847.8 848.1 854.6 854.9 836.5 843.5 845.7 847.1 849.7 615.6 620.3 624.7 626.4 627.3 12195.9 12238.2 12249.6 12271.8 12307.9 12530.6 12596.3 12679.4 12892.4 13245.1 9657.0 9727.3 9866.1 9919.4 10064.4 3273.0 3280.3 3285.2 3329.4 3397.1 40255.0 40849.8 41475.4 41480.0 41492.3 9778.7 9846.0 9864.8 9963.2 10096.7 16060.0 16155.8 16163.5 16184.9 16417.8 6564.5 6580.6 6625.8 6722.0 6829.6 3604.9 3730.4 3730.7 3774.2 3793.1 2665.1 2764.4 2766.3 3054.5 3178.4 517.3 528.1 531.7 531.8 536.0 585.5 588.1 595.3 595.4 619.3 7779.0 7813.5 7848.4 7960.2 8048.3 499.6 582.4 598.5 609.4 614.8 3161.0 3176.4 3216.4 3323.0 3721.5 55436.4 57307.4 57360.1 57644.7 57736.7 44279.0 49775.8 51709.6 52770.2 52774.2 41217.8 41520.6 41607.4 41657.4 41994.8 7984.6 7995.8 8092.2 8154.6 8188.6 29898.6 30112.5 30497.8 30601.2 30710.1 37091.4 38907.8 39619.4 39842.6 40014.6 10591.0 10691.8 10811.1 10916.8 10947.5 11421.9 11545.9 11683.3 11793.7 11884.3 11293.8 11313.9 11455.0 11722.0 11913.3 10436.6 11637.7 11689.5 11743.2 11744.3 11185.6 11224.9 11249.3 11289.4 11414.1 9701.7 9909.5 9958.3 10204.8 10405.1 9748.7 10092.1 10132.3 10156.2 10156.8 03:38:35 INFO - PROCESS | 16330 | -------- Summary: end -------- 03:38:35 INFO - PROCESS | 16330 | 03:38:36 INFO - TEST-INFO | 16330: exit 0 03:38:36 INFO - TEST-OK | dromaeo_css | took 1114309ms 03:38:36 INFO - TEST-START | kraken 03:38:36 INFO - operating with platform_type : linux_ 03:38:36 INFO - Initialising browser for kraken test... 03:38:36 INFO - TEST-INFO | started process 16562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsAtD6N/profile http://localhost:41565/getInfo.html) 03:38:39 INFO - PROCESS | 16562 | 03:38:39 INFO - PROCESS | 16562 | (process:16630): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:40 INFO - PROCESS | 16562 | __metrics Screen width/height:1600/1200 03:38:40 INFO - PROCESS | 16562 | colorDepth:24 03:38:40 INFO - PROCESS | 16562 | Browser inner width/height: 1024/697 03:38:40 INFO - PROCESS | 16562 | __metrics 03:38:41 ERROR - PROCESS | 16562 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:38:42 INFO - TEST-INFO | 16562: exit 0 03:38:42 INFO - Browser initialized. 03:38:42 INFO - Running cycle 1/1 for kraken test... 03:38:42 INFO - TEST-INFO | started process 16681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsAtD6N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:44 INFO - PROCESS | 16681 | 03:38:44 INFO - PROCESS | 16681 | (process:16741): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:54 INFO - PROCESS | 16681 | RSS: Main: 166268928 03:38:54 INFO - PROCESS | 16681 | 03:38:56 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41565/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:57 INFO - PROCESS | 16681 | RSS: Main: 170528768 03:38:57 INFO - PROCESS | 16681 | 03:39:00 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41565/tests/kraken/driver.html?testName=audio-dft) 03:39:01 INFO - PROCESS | 16681 | RSS: Main: 172875776 03:39:01 INFO - PROCESS | 16681 | 03:39:04 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41565/tests/kraken/driver.html?testName=audio-fft) 03:39:04 INFO - PROCESS | 16681 | RSS: Main: 166703104 03:39:04 INFO - PROCESS | 16681 | 03:39:06 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41565/tests/kraken/driver.html?testName=audio-oscillator) 03:39:07 INFO - PROCESS | 16681 | RSS: Main: 166473728 03:39:07 INFO - PROCESS | 16681 | 03:39:09 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:10 INFO - PROCESS | 16681 | RSS: Main: 166797312 03:39:10 INFO - PROCESS | 16681 | 03:39:13 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41565/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:14 INFO - PROCESS | 16681 | RSS: Main: 166887424 03:39:14 INFO - PROCESS | 16681 | 03:39:17 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41565/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:18 INFO - PROCESS | 16681 | RSS: Main: 166879232 03:39:18 INFO - PROCESS | 16681 | 03:39:21 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41565/tests/kraken/driver.html?testName=json-parse-financial) 03:39:21 INFO - PROCESS | 16681 | RSS: Main: 167022592 03:39:21 INFO - PROCESS | 16681 | 03:39:23 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:24 INFO - PROCESS | 16681 | RSS: Main: 167563264 03:39:24 INFO - PROCESS | 16681 | 03:39:26 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:26 INFO - PROCESS | 16681 | RSS: Main: 167596032 03:39:26 INFO - PROCESS | 16681 | 03:39:28 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:29 INFO - PROCESS | 16681 | RSS: Main: 167587840 03:39:29 INFO - PROCESS | 16681 | 03:39:32 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:33 INFO - PROCESS | 16681 | RSS: Main: 168062976 03:39:33 INFO - PROCESS | 16681 | 03:39:36 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:36 INFO - PROCESS | 16681 | RSS: Main: 168022016 03:39:36 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:41565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41565/tests/kraken/driver.html?testName=ai-astar) 03:39:38 INFO - PROCESS | 16681 | RSS: Main: 169443328 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | __start_tp_report 03:39:38 INFO - PROCESS | 16681 | _x_x_mozilla_page_load 03:39:38 INFO - PROCESS | 16681 | _x_x_mozilla_page_load_details 03:39:38 INFO - PROCESS | 16681 | |i|pagename|runs| 03:39:38 INFO - PROCESS | 16681 | |0;ai-astar;114;107;114;115;113;126;115;114;113;113 03:39:38 INFO - PROCESS | 16681 | |1;audio-beat-detection;162;135;169;181;141;178;162;133;187;133 03:39:38 INFO - PROCESS | 16681 | |2;audio-dft;161;166;162;164;176;162;160;163;166;164 03:39:38 INFO - PROCESS | 16681 | |3;audio-fft;74;76;73;159;75;76;74;76;151;75 03:39:38 INFO - PROCESS | 16681 | |4;audio-oscillator;96;98;155;94;95;94;153;94;94;145 03:39:38 INFO - PROCESS | 16681 | |5;imaging-gaussian-blur;117;119;117;118;117;118;118;117;118;118 03:39:38 INFO - PROCESS | 16681 | |6;imaging-darkroom;147;148;147;147;147;147;148;146;147;148 03:39:38 INFO - PROCESS | 16681 | |7;imaging-desaturate;95;100;95;96;95;99;96;95;95;95 03:39:38 INFO - PROCESS | 16681 | |8;json-parse-financial;67;69;68;68;66;67;67;89;66;65 03:39:38 INFO - PROCESS | 16681 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;65;65;66 03:39:38 INFO - PROCESS | 16681 | |10;stanford-crypto-aes;82;80;81;80;90;81;81;84;82;81 03:39:38 INFO - PROCESS | 16681 | |11;stanford-crypto-ccm;141;137;132;140;132;138;134;137;173;135 03:39:38 INFO - PROCESS | 16681 | |12;stanford-crypto-pbkdf2;181;180;181;183;182;177;176;180;182;179 03:39:38 INFO - PROCESS | 16681 | |13;stanford-crypto-sha256-iterative;74;71;72;73;74;73;73;70;71;71 03:39:38 INFO - PROCESS | 16681 | __end_tp_report 03:39:38 INFO - PROCESS | 16681 | __start_cc_report 03:39:38 INFO - PROCESS | 16681 | _x_x_mozilla_cycle_collect,905 03:39:38 INFO - PROCESS | 16681 | __end_cc_report 03:39:38 INFO - PROCESS | 16681 | __startTimestamp1462358378733__endTimestamp 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | ------- Summary: start ------- 03:39:38 INFO - PROCESS | 16681 | Number of tests: 14 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.67 (4.1%) stddev-sans-first:4.95 03:39:38 INFO - PROCESS | 16681 | Values: 114.0 107.0 114.0 115.0 113.0 126.0 115.0 114.0 113.0 113.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:165.50 stddev:21.06 (12.7%) stddev-sans-first:22.29 03:39:38 INFO - PROCESS | 16681 | Values: 162.0 135.0 169.0 181.0 141.0 178.0 162.0 133.0 187.0 133.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:4.53 (2.8%) stddev-sans-first:4.63 03:39:38 INFO - PROCESS | 16681 | Values: 161.0 166.0 162.0 164.0 176.0 162.0 160.0 163.0 166.0 164.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.00 stddev:33.85 (45.1%) stddev-sans-first:35.35 03:39:38 INFO - PROCESS | 16681 | Values: 74.0 76.0 73.0 159.0 75.0 76.0 74.0 76.0 151.0 75.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:94.00 stddev:27.19 (28.9%) stddev-sans-first:28.24 03:39:38 INFO - PROCESS | 16681 | Values: 96.0 98.0 155.0 94.0 95.0 94.0 153.0 94.0 94.0 145.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:39:38 INFO - PROCESS | 16681 | Values: 117.0 119.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:39:38 INFO - PROCESS | 16681 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 146.0 147.0 148.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.85 (2.0%) stddev-sans-first:1.92 03:39:38 INFO - PROCESS | 16681 | Values: 95.0 100.0 95.0 96.0 95.0 99.0 96.0 95.0 95.0 95.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:67.50 stddev:7.05 (10.4%) stddev-sans-first:7.43 03:39:38 INFO - PROCESS | 16681 | Values: 67.0 69.0 68.0 68.0 66.0 67.0 67.0 89.0 66.0 65.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 03:39:38 INFO - PROCESS | 16681 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.50 stddev:2.97 (3.6%) stddev-sans-first:3.15 03:39:38 INFO - PROCESS | 16681 | Values: 82.0 80.0 81.0 80.0 90.0 81.0 81.0 84.0 82.0 81.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:137.50 stddev:12.02 (8.7%) stddev-sans-first:12.75 03:39:38 INFO - PROCESS | 16681 | Values: 141.0 137.0 132.0 140.0 132.0 138.0 134.0 137.0 173.0 135.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:181.00 stddev:2.23 (1.2%) stddev-sans-first:2.35 03:39:38 INFO - PROCESS | 16681 | Values: 181.0 180.0 181.0 183.0 182.0 177.0 176.0 180.0 182.0 179.0 03:39:38 INFO - PROCESS | 16681 | 03:39:38 INFO - PROCESS | 16681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.40 (1.9%) stddev-sans-first:1.32 03:39:38 INFO - PROCESS | 16681 | Values: 74.0 71.0 72.0 73.0 74.0 73.0 73.0 70.0 71.0 71.0 03:39:38 INFO - PROCESS | 16681 | -------- Summary: end -------- 03:39:38 INFO - PROCESS | 16681 | 03:39:39 INFO - TEST-INFO | 16681: exit 0 03:39:39 INFO - TEST-OK | kraken | took 63617ms 03:39:39 INFO - SUITE-END | took 1177s 03:39:39 INFO - Completed test suite (00:19:38) 03:39:39 INFO - javascript benchmark 03:39:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.3267166872447, 2677.8259413138144, 2710.4443589064244, 2710.8614381959574, 2714.5113879501682, 4692.835750748724, 4694.319323698066, 4718.292256161569, 4726.102040612285, 4752.120857641339, 4586.289125185602, 4671.789769460374, 4710.623150147989, 4757.8096876125, 4768.1894078006735, 4288.892777680559, 4338.761368124752, 4369.584889435499, 4377.781110944456, 4418.403515525411, 4354.390385346038, 4365.126974605076, 4377.956220437803, 4379.802908869093, 4419.4033805436175, 4259.850905218303, 4262.041040765834, 4328.718633288826, 4352.325389564607, 4402.3836662867225, 4293.763842988635, 4321.524632290446, 4335.436393268855, 4343.500497442771, 4383.408239887638, 4230.619244267999, 4256.170046840867, 4258.54905720678, 4263.765492897889, 4310.48274207094, 4456.064226512436, 4523.050159466516, 4563.041761230145, 4569.95430045702, 4596.057808149321, 4952.0838644850455, 4956.553910148068, 4961.82633607822, 4974.079795237856, 5011.223260394645, 4800.207965685658, 5004.749762511896, 5021.472745361721, 5046.520580544842, 5085.0, 4678.602318802906, 4696.835610753607, 4700.952990470051, 4734.3371927929775, 4751.596114330251, 5127.307813445212, 5169.793208271627, 5175.042617115846, 5180.611454140954, 5206.140986737146, 4785.210440277385, 4961.702297862068, 4965.726885021359, 4972.8508144755715, 5024.62315326352, 4954.108260513142, 4964.975175124101, 5004.824831130893, 5025.623078269145, 5046.646734728533, 4896.314515967767, 4930.852074437773, 5006.799728010911, 5019.146745053276, 5053.2420136979745, 4912.9508704913205, 4936.975315123402, 4961.950380496221, 4967.081089998362, 4992.625553083533, 4321.762303073298, 4350.369196466558, 4361.5856493633055, 4377.387165796791, 4387.934180987288, 3731.6081811409954, 3751.1372384351753, 3756.1924186300075, 3777.8488860445823, 3779.3952967525065, 4272.316429371348, 4308.569143085666, 4348.9565104349185, 4376.234159022159, 4412.183746006999, 5082.491750824888, 5084.034033533617, 5084.186530155157, 5090.974545127251, 5107.61692873036, 4351.782410879443, 4372.300431930939, 4372.956270437255, 4389.604935555815, 4425.203463376559, 4470.843520476833, 4504.932426013613, 4508.977455112704, 4572.7713614319155, 4589.151007063704, 4764.118638051971, 4768.999999999931, 4779.187538118528, 4796.088743138793, 4800.759962001886, 5064.645474816874, 5069.898602028013, 5071.239314102914, 5074.6194035448225, 5089.083964886356, 4650.767461626838, 4658.510856360033, 4722.173619616485, 4735.857924262277, 4787.066522028171, 4982.053409852117, 4982.377202849644, 5007.273945277841, 5013.147764879906, 5052.9494705052475, 5073.315102461121, 5077.593792496666, 5079.111155547838, 5082.364704411949, 5131.87170320745, 4785.641076919175, 4807.375041244616, 4839.95160048395, 4876.853694389174, 4900.632452566, 4775.904481910273, 4855.150348689036, 4856.805727770991, 4863.367762190893, 4915.311856340187, 4809.134355815847, 4851.345068415719, 4853.49038350968, 4860.513948605111, 4884.92672609904, 4805.063012712627, 4851.029794041277, 4935.555799978019, 4960.206366981266, 4980.452150263396, 4807.879803004953, 4818.903621927471, 4819.662623616313, 4837.105135549935, 4877.512248775094], "value": 4620.820490091446, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7447660267784, 607.893618616742, 614.6680792372119, 631.3055638797322, 637.6014990630856, 34594.13514662132, 35482.0, 35604.82197589015, 35606.643933560656, 35919.82040089799, 35376.823115884385, 36031.459528107036, 36052.0, 36061.81969090151, 36092.278154436965, 7396.70413183472, 7565.962170189141, 7571.356434703057, 7616.504927179715, 7636.312731854132, 7668.731594394198, 7765.728199513018, 7816.218378162167, 7823.569703666296, 7831.216878312181, 7725.266099720546, 7801.882971755428, 7821.921780782205, 7827.295543401093, 7854.332381747558, 7712.884306735404, 7736.110347310075, 7785.299323060952, 7826.452148349618, 7827.765167044998, 7580.1661817200065, 7699.4995325304235, 7734.729284475016, 7736.7292144774665, 7740.458167928247, 25891.74108258912, 35900.82049589735, 36355.27289454223, 36476.088097797765, 36682.0, 2951.199733337315, 2973.3458639099363, 3110.3623757129963, 3166.794158379721, 3173.1908363367424, 26937.86531067352, 27974.160775176777, 28330.85834570814, 28409.715902840915, 29131.41737165266, 3389.661033896615, 3450.9058132509354, 3470.6529347065343, 3497.440409534462, 3593.0658028912408, 102598.48700756449, 103067.48466257696, 104201.0, 104478.47760761224, 104752.0, 58144.709276453345, 58996.41003589995, 59153.0, 59212.0, 59555.0, 54381.0, 55222.85828562793, 55326.72336638291, 55425.168622470694, 62865.37134628687, 14032.228227447384, 14294.571162865132, 14361.138331700131, 14425.278736063365, 14428.85571144296, 10815.080718139046, 11025.889741102486, 11047.226694131334, 11057.336559806437, 11087.168462365193, 19096.140673669717, 19154.233830646896, 19184.232630694616, 19188.71216931747, 19202.13590388436, 7593.0, 7650.579218143055, 7653.617319134132, 7676.155622881479, 7712.344450721639, 864.6282098697494, 882.4925667741074, 932.7901222224945, 981.5779214937645, 1053.6904062384883, 26085.219241507733, 26123.216303510926, 26488.47023059528, 26489.20532383993, 26515.734842651713, 972.7519482531909, 980.6028558433845, 988.6737376665683, 1079.1636481726725, 1079.5304042741432, 14220.71558568823, 14441.711165776625, 14444.855551444562, 14565.635859103608, 14705.852941470663, 358446.0, 363953.0, 366170.0, 366362.0, 366456.0, 49457.752711236935, 50463.0, 50499.99000019979, 50719.0, 50813.0, 1173.9514547115339, 1229.6188181663713, 1233.96915077122, 1239.156136666353, 1245.5391505143155, 26240.475190496465, 26837.194884153505, 26926.192214233604, 27511.86244068767, 27569.172924812287, 42917.0, 43272.0, 43277.56722432861, 43560.56439435565, 43733.125337492434, 324762.0, 326523.0, 329273.0, 329549.0, 329936.0, 25733.613995790452, 26424.735752642227, 35440.64559354373, 36469.45295820618, 36480.0, 38197.427038595, 38212.23575528529, 38706.80646596749, 38867.222655547295, 39196.41205381979, 33253.667463326026, 34178.48732269068, 35935.82032089823, 36074.0, 36232.27535449224, 35125.473117902744, 35167.47248791219, 35368.46947295741, 35407.0, 35882.10294742652, 34947.30105397827, 35044.82477587596, 35626.643733562334, 36185.45721814228, 36289.09277267984, 30922.226944325674, 31904.0, 32054.19864503406, 32249.35501289914, 32288.83855580707, 24946.750532494443, 24997.500049998533, 25141.120060797784, 25251.11621093253, 25636.743632563437], "value": 17112.010879411508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7299231049799, 383.10544877710544, 383.99040023999396, 384.66149788186397, 389.0759446315002, 15687.0, 16151.515454536368, 16940.83059169408, 16963.406280780175, 16972.405965791186, 14127.505537306197, 16138.354465821352, 16577.0, 16614.916925415386, 16684.165791710395, 4541.386912766776, 4670.1126785910565, 4701.294805779144, 4708.19960606696, 4710.905781884378, 3336.9332613347838, 4958.6281028922795, 5239.79040838366, 5259.0796610593, 5259.76331065103, 5221.138512145491, 5236.842894713165, 5240.60695447841, 5246.895062098756, 5257.5005374489365, 5343.7328133593355, 5850.736716847752, 5895.64626122434, 5918.556108291874, 5920.644761314314, 4750.239961606127, 5244.108501554745, 5274.077036518594, 5274.604404669627, 5284.154535274338, 11882.881171188264, 12088.395580221042, 12119.93940030303, 12205.877941220651, 12212.755744885142, 1874.287770647159, 1917.1947781931622, 1924.2399252295404, 1925.2491528303972, 2363.1610778173845, 8485.83028339436, 8559.657613695445, 8745.387822852403, 8787.121287871161, 8921.107889211093, 1682.2177687375429, 1696.177353983317, 1715.536017783364, 1723.7069698151345, 1809.7737782777153, 66541.0, 69266.0, 69578.0, 70107.64946175288, 71118.28881711168, 8968.68609598661, 9151.679691210775, 9845.261605379483, 10171.796564068678, 10666.546694260363, 13663.043586949017, 13691.0, 13712.0, 13722.0, 13759.17444953306, 6885.690143943534, 7003.299670032956, 7069.787906362817, 7099.858002839915, 7147.785566433015, 6553.770618028346, 6567.376099270562, 6598.241202261705, 6858.129002653528, 6887.621180835002, 4046.8178931947546, 4063.553009168989, 4167.749935003849, 4292.141571685675, 4409.184300904343, 1720.8623310135158, 1797.6764182447023, 1832.2121487760392, 1874.6625607390529, 1908.7900330963582, 863.5509535041743, 916.9358144929924, 925.3337596930199, 949.0367277213634, 952.994590706811, 15318.846811531965, 15672.686546269011, 15885.920570397306, 16029.19854007295, 16109.0, 856.1609622569916, 882.0517943211074, 889.3147485514913, 933.2160984772823, 948.814981078683, 9212.769680757901, 9247.537623118817, 9314.0, 9563.330566860392, 9684.70945871625, 407055.0, 408608.0, 409518.0, 414144.0, 419350.0, 76532.0, 77421.61289193518, 78750.60624696955, 79277.60361198272, 79456.0, 933.7945651956694, 949.1505102932974, 969.6024629901707, 979.490664854286, 993.0913214408735, 14802.779583062627, 15040.774388384401, 15079.849201508283, 15185.088894666356, 15460.690786184437, 34360.312793743484, 34770.130746731535, 35106.473402899486, 35501.28997420089, 35874.46188307125, 48236.27645585389, 48483.5151648479, 49163.0, 50433.24350134678, 50462.49537504578, 7306.3789577884345, 7330.193678695233, 7340.0, 7369.742059028123, 7544.245575442631, 9797.0, 10606.575736970743, 11008.339499630049, 11067.0, 11304.0, 9311.953440233026, 9434.150926416381, 9580.041995800364, 9740.659076932274, 9883.0, 9362.906370936204, 9810.901890980998, 9971.152452041657, 10020.849687254551, 10251.436171010666, 9585.424874507273, 9833.852492212765, 9899.307048506535, 10011.299209055296, 10106.848397274194, 7442.665080071301, 7460.776176714708, 7479.364254038468, 7557.2820582044615, 7581.128170260491, 8712.520811355436, 10207.795844083224, 10370.533326000499, 10404.375737455777, 10816.56733730642], "value": 7941.206158758366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.4210844607935, 1431.8568143185682, 1510.6525499135198, 1616.9272382742774, 1619.0852168524775, 6257.624542527452, 6779.830504237397, 6924.20371657259, 7225.5664660120365, 7226.313500217471, 6661.300563440842, 6666.366695163963, 6726.6300353480665, 6754.290799466059, 6785.219699734532, 2082.7084208210827, 2140.871547707143, 2141.4004078857943, 2143.228437762404, 2148.98925505373, 2050.8872012039333, 2099.653557163066, 2102.55846272283, 2118.184498967893, 2127.702121702963, 2059.3204242599904, 2079.1475495047034, 2091.2785089144295, 2100.2019232691555, 2103.663413853784, 2062.4328309714797, 2065.8863762493056, 2069.079259729421, 2074.958500829975, 2083.135498768017, 1999.5001249687577, 2019.6162729081575, 2025.1494372363643, 2037.7350944377135, 2048.2319130326127, 6912.585244885273, 6916.3429474199875, 6925.342092501204, 6952.826179345506, 6954.3045695430055, 4226.175895700339, 4350.956490435086, 4376.8686939391555, 4381.737095774264, 4383.890402739957, 2663.7735792457665, 2802.453521563296, 2821.50623640862, 2822.50606143924, 2836.0, 952.1716106986966, 957.0477375011839, 962.138885697304, 973.6446197137993, 988.5057471264367, 9431.952840235823, 9447.866256049318, 9485.051494850528, 9485.193758530533, 9510.28672849532, 3883.475730776309, 3952.2095580883365, 3974.7615143091507, 4048.4129801178665, 4050.716449848482, 8303.501789892625, 8332.125126861714, 8351.1648835116, 8355.665773369119, 8374.49753014821, 4327.740335579875, 4350.0, 4356.0, 4366.956330436718, 4367.912641747147, 3493.0219538529254, 3896.2207558488417, 3986.22268657609, 4018.8794336169963, 4054.087830238173, 3353.748468864845, 3403.608585012755, 3428.5371474850576, 3434.1242983039165, 3523.083998160497, 1112.694009147491, 1152.6196355202762, 1152.7002979225463, 1153.2561497834017, 1167.8088349883071, 814.9388795840217, 865.1348651348651, 868.7654333329965, 906.6237511432813, 908.5911339897073, 5150.690958542425, 5167.715775632301, 5222.686638801684, 5223.451537588575, 5348.171033489815, 888.8666699995052, 907.4782000349825, 921.8663293822358, 935.9812803743887, 949.2832911152036, 3452.775569588019, 3460.1522626956557, 3490.877819276313, 3538.5399898013093, 3557.9288414232087, 8194.836103277901, 8476.152384761597, 8568.785780355542, 8573.828523429496, 8575.828483430296, 8378.916210837935, 8468.703595374132, 8559.058503564604, 8560.272376847914, 8569.528675922884, 6677.09859169006, 6747.763828265987, 6873.828154296182, 6874.484413668994, 6891.310868913069, 4922.335484709519, 4936.555709986119, 5029.189491782882, 5042.621803364689, 5087.160618497906, 8124.22819832115, 8155.959220203861, 8164.83670326602, 8188.50868947865, 8225.71210007647, 7689.423293252917, 7997.480163789335, 8002.759917202493, 8070.071941726542, 8301.792455188668, 5735.197072409783, 6076.817695469143, 6273.121762953099, 6274.686265686789, 6420.935790642221, 6600.0, 6606.0, 6637.137172167587, 6665.900011499734, 6719.832004199934, 6123.234595675541, 6325.177726895474, 6387.137736405712, 6431.260405053292, 6432.742690292336, 6088.6042407243385, 6108.877822443437, 6190.380961903774, 6223.813285601439, 6258.0, 5876.500497457764, 5918.644881307136, 5952.761889524544, 5987.491063259672, 6007.219061521974, 4398.538153493965, 4484.9103017940115, 4504.819807207675, 4531.524189960139, 4598.770061496845, 4361.411209486679, 4457.888552786207, 4501.18978583858, 4543.204939135572, 4583.656225783013], "value": 3913.2518174280303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.85796388751453, 298.1027108403705, 302.6821837071075, 303.5643851073709, 310.1950438611802, 4695.67130300879, 4811.615070794337, 4824.107540105074, 4938.580220681242, 4941.87645308867, 4870.512948705128, 4877.8781230164905, 4903.754812259391, 4908.165611845986, 4913.3612630358, 3812.1613245086105, 3827.349350610389, 3840.327942610046, 3849.3840985442334, 3869.632384923442, 3774.4338349247696, 3859.6912247020173, 3860.7645553422917, 3865.3042452358563, 3879.941800872975, 3779.1496913194587, 3797.3924172132465, 3805.562360328556, 3830.291396091732, 3841.8463261469506, 3785.5268091488565, 3794.658480736733, 3807.8857634270876, 3823.6941044716355, 3852.460655508231, 3395.7266025240533, 3406.7785593936314, 3435.57055368079, 3438.277961628061, 3445.552078229814, 4416.712913660602, 4693.718376897363, 4723.692959957626, 4732.337472753818, 4743.268706921948, 4260.318349064166, 4297.67767417445, 4297.8495752648505, 4325.221460137174, 4335.653147748172, 5122.615803814691, 5124.205748109049, 5146.665466744649, 5173.560247378978, 5173.81891633791, 3562.536870206882, 3643.708503319728, 3648.1426864686778, 3662.61542538035, 3670.4127339625798, 5207.401148867891, 5335.1997200419855, 5359.437259087778, 5367.919481207785, 5422.539084177889, 3692.833822477995, 3712.480252764615, 3726.888193354204, 3734.607866174067, 3741.56971948224, 3764.322421964018, 3768.6231376862643, 3782.394816829294, 3783.9432408513894, 3784.2242340320167, 4041.393790931325, 4296.591823776799, 4304.5910638489295, 4306.80619372129, 4345.3699213613845, 5074.517920797518, 5107.284980102789, 5123.923141152885, 5136.049830781318, 5138.203578445347, 1282.7819270723999, 1320.9801852972214, 1362.5503583817317, 1365.0308281120515, 1366.9931650341684, 890.2922176869405, 900.4012331799411, 903.1239697493421, 903.3468752183488, 910.1490106750077, 4701.294805779161, 4707.95292047082, 4726.952730472652, 4733.715977041388, 4741.9051618968115, 5514.6691198528215, 5527.613067085265, 5548.86127846799, 5583.292103329882, 5594.440555944454, 4583.129205450954, 4705.247160454311, 4708.411448568929, 4719.480857105716, 4724.149653062482, 2948.4545359108633, 2953.3354995126356, 2962.126172779035, 2965.273507990556, 2973.8215707057648, 5184.870378240575, 5193.246979187997, 5229.973850130801, 5257.63196576236, 5267.841964741064, 5497.285352904177, 5651.434856514398, 5657.660540367591, 5679.148127780783, 5738.311402631711, 5254.6847189168775, 5263.526282634582, 5269.104252277122, 5272.657277277041, 5281.683099013994, 5483.479069488392, 5536.44979405767, 5566.24855644499, 5591.077472217039, 5593.244911936837, 5342.78628854857, 5417.485338892799, 5424.267723857229, 5439.096316289267, 5442.619016668954, 5192.870178245574, 5205.308274810777, 5209.973950130377, 5239.109351410346, 5263.763130659206, 3857.61423857612, 3862.1889403225637, 3872.96127038726, 3879.6809084910137, 3885.553161386477, 4986.47641997585, 5334.333208348957, 5540.501354878081, 5564.10974244119, 5577.27495425592, 5024.598032157345, 5115.820946266863, 5171.3535808024, 5185.429602743619, 5189.740512974412, 5149.510796474329, 5163.66436181647, 5176.611754118381, 5177.4822517747925, 5190.8961820762615, 4886.462489126265, 5068.82259120929, 5094.439611642642, 5095.414027386898, 5096.0827051131155, 5186.766595503136, 5197.532222100029, 5229.450907654794, 5245.816396426107, 5265.7367131642495, 5120.48795120485, 5129.640925135354, 5131.384233891957, 5141.691498510101, 5149.48090313351], "value": 3934.7912596196984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.7869481765835, 681.3901558105495, 751.5378042503859, 762.626313106578, 776.7436745873858, 12126.636200913976, 12538.122331436804, 12538.185017973825, 12552.560660376888, 12562.0, 11546.769064618702, 11623.709407264823, 11624.883751162486, 11692.947634712875, 11738.178327517076, 612.1735656863243, 785.2540086917422, 797.4417907464768, 798.0184373220912, 798.3294033012269, 780.0950896959528, 804.4489524675587, 805.899262592176, 806.9717559885405, 810.6635746165334, 841.2134654098408, 847.7795773098977, 848.0544193224541, 854.6239654551978, 854.9102344253857, 836.4688422851502, 843.5149788871393, 845.6701886264361, 847.1486156412766, 849.6771226933787, 615.6306216270247, 620.2928661326092, 624.6782906803, 626.3673689573518, 627.3005598757353, 12195.878041219563, 12238.204516706475, 12249.632511024594, 12271.815922761076, 12307.876921230853, 12530.561430349893, 12596.307203103826, 12679.429425675868, 12892.41984110708, 13245.07284490086, 9657.0, 9727.270454715925, 9866.112049915542, 9919.404835709809, 10064.446455444948, 3273.0, 3280.2783387654677, 3285.1951271938287, 3329.3674201901563, 3397.1167496450853, 40255.0, 40849.79575102135, 41475.377869331984, 41480.0, 41492.28661980988, 9778.65774697882, 9846.0, 9864.753381165528, 9963.153131983718, 10096.747581310527, 16060.0, 16155.757663635055, 16163.515094546947, 16184.919075404783, 16417.753733694004, 6564.540482166202, 6580.605163690194, 6625.834354141089, 6722.0, 6829.590224586541, 3604.85580576774, 3730.421784623388, 3730.6828919542145, 3774.169682669808, 3793.1275806564645, 2665.120510231619, 2764.3918337965615, 2766.2531116598407, 3054.480738274499, 3178.364327134536, 517.3068088761078, 528.118042868403, 531.6836482293029, 531.8377894742064, 536.0378121272248, 585.5140233606097, 588.069041090451, 595.3034949109552, 595.382806336855, 619.2723549828933, 7778.961105194438, 7813.492123011986, 7848.372130229568, 7960.2039796019935, 8048.315893149031, 499.61030396290954, 582.3797655496883, 598.5211830535554, 609.3601718195877, 614.7940439952577, 3161.0200837740376, 3176.3647270545985, 3216.3728073025536, 3322.983385083059, 3721.5348081489815, 55436.44563554393, 57307.426925731044, 57360.13959790606, 57644.71177644085, 57736.71131644399, 44279.0, 49775.75112124416, 51709.63887347386, 52770.20844687256, 52774.20838687423, 41217.79391103085, 41520.58479415227, 41607.37588936168, 41657.37513937233, 41994.790026049675, 7984.600769961595, 7995.760127196193, 8092.190780921861, 8154.551499667576, 8188.5905704715715, 29898.551521727626, 30112.54831177578, 30497.847510763193, 30601.23496912595, 30710.078697639106, 37091.44362834613, 38907.80546097364, 39619.405708913815, 39842.60157398505, 40014.599854001084, 10591.042034758006, 10691.839622405514, 10811.081058109834, 10916.78166436651, 10947.45262736844, 11421.942890285827, 11545.88454115448, 11683.299002059903, 11793.705157371134, 11884.34636095023, 11293.774124517628, 11313.886861131283, 11455.0, 11722.0, 11913.285202887855, 10436.63471778484, 11637.650870473899, 11689.473973671375, 11743.177977541833, 11744.29534227949, 11185.608503702331, 11224.887751122711, 11249.325040497597, 11289.435528223721, 11414.14393920476, 9701.6604418845, 9909.504524773589, 9958.253131015057, 10204.846927296245, 10405.115565177044, 9748.707538773848, 10092.14216791581, 10132.34139780912, 10156.18750499973, 10156.796864062826], "value": 5942.484993130881, "unit": "score"}], "name": "dromaeo_css", "value": 6211.986942767993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 114.0, 115.0, 113.0, 126.0, 115.0, 114.0, 113.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 169.0, 181.0, 141.0, 178.0, 162.0, 133.0, 187.0, 133.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 162.0, 164.0, 176.0, 162.0, 160.0, 163.0, 166.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 159.0, 75.0, 76.0, 74.0, 76.0, 151.0, 75.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 155.0, 94.0, 95.0, 94.0, 153.0, 94.0, 94.0, 145.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 96.0, 95.0, 99.0, 96.0, 95.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 66.0, 67.0, 67.0, 89.0, 66.0, 65.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 81.0, 80.0, 90.0, 81.0, 81.0, 84.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 132.0, 140.0, 132.0, 138.0, 134.0, 137.0, 173.0, 135.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 181.0, 183.0, 182.0, 177.0, 176.0, 180.0, 182.0, 179.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 72.0, 73.0, 74.0, 73.0, 73.0, 70.0, 71.0, 71.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1609.4, "alertThreshold": 2.0}]} 03:39:39 INFO - Return code: 0 03:39:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:39:40 ERROR - # TBPL SUCCESS # 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - Running post-run listener: _resource_record_post_run 03:39:41 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 349814784; Read time: 0; Write time: 258456 03:39:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69021696; Read time: 0; Write time: 69824 03:39:41 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 280793088; Read time: 0; Write time: 188632 03:39:41 INFO - Running post-run listener: _upload_blobber_files 03:39:41 INFO - Blob upload gear active. 03:39:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:39:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:42 INFO - (blobuploader) - INFO - Done attempting. 03:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:43 INFO - (blobuploader) - INFO - Done attempting. 03:39:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:43 INFO - Return code: 0 03:39:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70880f6c98030a4fde9661158c23220119f1bcf976d0edf3eb0244e310d4e4bedb1cec5291726459c14bda21cf98aab215bb05867c5a3d9617a24b35ed81582e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a25337975a9f53ed158282a2d94b2640a3de72f1bce1c968b53cd6fc1a2cef901a2b4d26e535e676f1b6a8f1429fb80f9c1f3b6cbeac8f029048ea097f2904da"} 03:39:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:43 INFO - Contents: 03:39:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70880f6c98030a4fde9661158c23220119f1bcf976d0edf3eb0244e310d4e4bedb1cec5291726459c14bda21cf98aab215bb05867c5a3d9617a24b35ed81582e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a25337975a9f53ed158282a2d94b2640a3de72f1bce1c968b53cd6fc1a2cef901a2b4d26e535e676f1b6a8f1429fb80f9c1f3b6cbeac8f029048ea097f2904da"} 03:39:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:43 INFO - Copying logs to upload dir... 03:39:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2132.965857 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 32 secs) (at 2016-05-04 03:39:42.961798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 03:39:42.965396) ========= 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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70880f6c98030a4fde9661158c23220119f1bcf976d0edf3eb0244e310d4e4bedb1cec5291726459c14bda21cf98aab215bb05867c5a3d9617a24b35ed81582e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a25337975a9f53ed158282a2d94b2640a3de72f1bce1c968b53cd6fc1a2cef901a2b4d26e535e676f1b6a8f1429fb80f9c1f3b6cbeac8f029048ea097f2904da"} build_url:https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/Hb-mS5WPTnyO1Ybm0zmH6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70880f6c98030a4fde9661158c23220119f1bcf976d0edf3eb0244e310d4e4bedb1cec5291726459c14bda21cf98aab215bb05867c5a3d9617a24b35ed81582e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a25337975a9f53ed158282a2d94b2640a3de72f1bce1c968b53cd6fc1a2cef901a2b4d26e535e676f1b6a8f1429fb80f9c1f3b6cbeac8f029048ea097f2904da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 03:39:42.996779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:39:42.997310) ========= 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=826874ccc97bd7bf541b4875000001d5-1462356222.916793-10129495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 03:39:43.080589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 03:39:43.080911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 03:39:43.081194) ========= ========= Total master_lag: 0.17 =========