builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1461768820.85 results: success (0) buildid: 20160427071021 builduid: 07fc49fce654442d863738e4571b4e52 revision: 0a2e98e3e736ac03f53cf844113b2029213e4af4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:40.845714) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:40.846154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:40.846449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:40.911550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:40.911819) ========= 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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 07:53:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-04-27 07:53:41 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.056703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.056997) ========= 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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017930 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.114558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.114995) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0a2e98e3e736ac03f53cf844113b2029213e4af4 --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 0a2e98e3e736ac03f53cf844113b2029213e4af4 --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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 07:53:41,674 truncating revision to first 12 chars 2016-04-27 07:53:41,675 Setting DEBUG logging. 2016-04-27 07:53:41,675 attempt 1/10 2016-04-27 07:53:41,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0a2e98e3e736?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 07:53:41,945 unpacking tar archive at: fx-team-0a2e98e3e736/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.699606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.699923) ========= script_repo_revision: 0a2e98e3e736ac03f53cf844113b2029213e4af4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.700308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.700578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:53:41.711651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-27 07:53:41.712049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:53:42 INFO - MultiFileLogger online at 20160427 07:53:42 in /builds/slave/test 07:53:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:53:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:42 INFO - {'append_to_log': False, 07:53:42 INFO - 'base_work_dir': '/builds/slave/test', 07:53:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:53:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:42 INFO - 'branch': 'Fx-Team-Non-PGO', 07:53:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:42 INFO - 'config_files': ('talos/linux_config.py',), 07:53:42 INFO - 'default_actions': ('clobber', 07:53:42 INFO - 'read-buildbot-config', 07:53:42 INFO - 'download-and-extract', 07:53:42 INFO - 'populate-webroot', 07:53:42 INFO - 'create-virtualenv', 07:53:42 INFO - 'install', 07:53:42 INFO - 'run-tests'), 07:53:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:42 INFO - 'download_minidump_stackwalk': True, 07:53:42 INFO - 'download_symbols': 'ondemand', 07:53:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:42 INFO - 'installer_path': 'installer.exe', 07:53:42 INFO - 'log_level': 'info', 07:53:42 INFO - 'log_name': 'talos', 07:53:42 INFO - 'log_to_console': True, 07:53:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:53:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:53:42 INFO - 'opt_config_files': (), 07:53:42 INFO - 'pip_index': False, 07:53:42 INFO - 'sps_profile': False, 07:53:42 INFO - 'sps_profile_interval': 0, 07:53:42 INFO - 'suite': 'dromaeojs', 07:53:42 INFO - 'system_bits': '32', 07:53:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:42 INFO - 'title': 'talos-linux64-ix-055', 07:53:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:42 INFO - 'use_talos_json': True, 07:53:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:42 INFO - 'work_dir': 'build'} 07:53:42 INFO - ##### 07:53:42 INFO - ##### Running clobber step. 07:53:42 INFO - ##### 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: clobber 07:53:42 INFO - rmtree: /builds/slave/test/build 07:53:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:42 INFO - Running post-action listener: _resource_record_post_action 07:53:42 INFO - ##### 07:53:42 INFO - ##### Running read-buildbot-config step. 07:53:42 INFO - ##### 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: read_buildbot_config 07:53:42 INFO - Using buildbot properties: 07:53:42 INFO - { 07:53:42 INFO - "project": "", 07:53:42 INFO - "product": "firefox", 07:53:42 INFO - "script_repo_revision": "production", 07:53:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:53:42 INFO - "repository": "", 07:53:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:53:42 INFO - "buildid": "20160427071021", 07:53:42 INFO - "pgo_build": "False", 07:53:42 INFO - "basedir": "/builds/slave/test", 07:53:42 INFO - "buildnumber": 2901, 07:53:42 INFO - "slavename": "talos-linux64-ix-055", 07:53:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:53:42 INFO - "platform": "ubuntu64_hw", 07:53:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:53:42 INFO - "branch": "fx-team", 07:53:42 INFO - "repo_path": "integration/fx-team", 07:53:42 INFO - "revision": "0a2e98e3e736ac03f53cf844113b2029213e4af4", 07:53:42 INFO - "stage_platform": "linux64", 07:53:42 INFO - "builduid": "07fc49fce654442d863738e4571b4e52", 07:53:42 INFO - "slavebuilddir": "test" 07:53:42 INFO - } 07:53:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:53:42 INFO - Running post-action listener: _resource_record_post_action 07:53:42 INFO - ##### 07:53:42 INFO - ##### Running download-and-extract step. 07:53:42 INFO - ##### 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: download_and_extract 07:53:42 INFO - mkdir: /builds/slave/test/build/tests 07:53:42 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')]} 07:53:42 INFO - https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:43 INFO - Downloaded 1361 bytes. 07:53:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:53:43 INFO - Using the following test package requirements: 07:53:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:53:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:53:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'jsshell-linux-x86_64.zip'], 07:53:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:53:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:53:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:53:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:53:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:53:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:53:43 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')]} 07:53:43 INFO - https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:44 INFO - Downloaded 22294440 bytes. 07:53:44 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'] 07:53:44 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 07:53:46 INFO - Return code: 0 07:53:46 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 07:53:46 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')]} 07:53:46 INFO - https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:47 INFO - Downloaded 22294440 bytes. 07:53:47 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'] 07:53:47 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 07:53:49 INFO - Return code: 0 07:53:49 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')]} 07:53:49 INFO - https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:50 INFO - Downloaded 10840145 bytes. 07:53:50 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'] 07:53:50 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 07:53:50 INFO - Return code: 0 07:53:50 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')]} 07:53:50 INFO - https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXly6XKLRpie2f1OpQUBBw/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 07:53:51 INFO - Downloaded 54819322 bytes. 07:53:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:53:51 INFO - mkdir: /builds/slave/test/properties 07:53:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:53:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:53:51 INFO - Contents: 07:53:51 INFO - build_url:https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:53:52 INFO - Running post-action listener: _resource_record_post_action 07:53:52 INFO - Running post-action listener: set_extra_try_arguments 07:53:52 INFO - ##### 07:53:52 INFO - ##### Running populate-webroot step. 07:53:52 INFO - ##### 07:53:52 INFO - Running pre-action listener: _resource_record_pre_action 07:53:52 INFO - Running main action method: populate_webroot 07:53:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:52 INFO - '--tppagecycles', 07:53:52 INFO - '7'], 07:53:52 INFO - 'tests': ['tsvgm']}}, 07:53:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:53:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:53:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:53:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['damp', 'tps']}, 07:53:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'tests': ['damp', 'tps']}, 07:53:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['dromaeo_dom']}, 07:53:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['a11yr', 07:53:52 INFO - 'ts_paint', 07:53:52 INFO - 'tpaint', 07:53:52 INFO - 'sessionrestore', 07:53:52 INFO - 'sessionrestore_no_auto_restore', 07:53:52 INFO - 'tabpaint']}, 07:53:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['tsvgx', 07:53:52 INFO - 'tsvgr_opacity', 07:53:52 INFO - 'tart', 07:53:52 INFO - 'tscrollx', 07:53:52 INFO - 'cart']}, 07:53:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:53:52 INFO - 'tsvgr_opacity', 07:53:52 INFO - 'tart', 07:53:52 INFO - 'tscrollx', 07:53:52 INFO - 'cart']}, 07:53:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'talos_options': ['--disable-e10s'], 07:53:52 INFO - 'tests': ['tp5o']}, 07:53:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'tests': ['tp5o']}, 07:53:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'talos_options': ['--disable-e10s', 07:53:52 INFO - '--xperf_path', 07:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:52 INFO - 'tests': ['tp5n']}, 07:53:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:52 INFO - 'talos_options': ['--xperf_path', 07:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:52 INFO - 'tests': ['tp5n']}}, 07:53:52 INFO - 'talos.zip': {'path': '', 07:53:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:52 INFO - Running post-action listener: _resource_record_post_action 07:53:52 INFO - ##### 07:53:52 INFO - ##### Running create-virtualenv step. 07:53:52 INFO - ##### 07:53:52 INFO - Running pre-action listener: _resource_record_pre_action 07:53:52 INFO - Running main action method: create_virtualenv 07:53:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:53:52 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 07:53:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:53:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:52 INFO - Using real prefix '/usr' 07:53:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:53:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:54 INFO - Installing pip.................done. 07:53:54 INFO - Return code: 0 07:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53:54 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')]} 07:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:54 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')]} 07:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:54 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:53:54 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 07:53:54 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 07:53:54 INFO - Using env: {'DISPLAY': ':0', 07:53:54 INFO - 'HOME': '/home/cltbld', 07:53:54 INFO - 'LANG': 'en_US.UTF-8', 07:53:54 INFO - 'LANGUAGE': 'en_US:en', 07:53:54 INFO - 'LOGNAME': 'cltbld', 07:53:54 INFO - 'MAIL': '/var/mail/cltbld', 07:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:54 INFO - 'MOZ_NO_REMOTE': '1', 07:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:54 INFO - 'NO_EM_RESTART': '1', 07:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:54 INFO - 'PWD': '/builds/slave/test', 07:53:54 INFO - 'SHELL': '/bin/bash', 07:53:54 INFO - 'SHLVL': '1', 07:53:54 INFO - 'TERM': 'linux', 07:53:54 INFO - 'TMOUT': '86400', 07:53:54 INFO - 'USER': 'cltbld', 07:53:54 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:54 INFO - '_': '/tools/buildbot/bin/python'} 07:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:55 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 07:53:55 INFO - Cleaning up... 07:53:55 INFO - Return code: 0 07:53:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:53:55 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')]} 07:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:55 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')]} 07:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:55 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:53:55 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 07:53:55 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 07:53:55 INFO - Using env: {'DISPLAY': ':0', 07:53:55 INFO - 'HOME': '/home/cltbld', 07:53:55 INFO - 'LANG': 'en_US.UTF-8', 07:53:55 INFO - 'LANGUAGE': 'en_US:en', 07:53:55 INFO - 'LOGNAME': 'cltbld', 07:53:55 INFO - 'MAIL': '/var/mail/cltbld', 07:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:55 INFO - 'MOZ_NO_REMOTE': '1', 07:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:55 INFO - 'NO_EM_RESTART': '1', 07:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:55 INFO - 'PWD': '/builds/slave/test', 07:53:55 INFO - 'SHELL': '/bin/bash', 07:53:55 INFO - 'SHLVL': '1', 07:53:55 INFO - 'TERM': 'linux', 07:53:55 INFO - 'TMOUT': '86400', 07:53:55 INFO - 'USER': 'cltbld', 07:53:55 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:55 INFO - '_': '/tools/buildbot/bin/python'} 07:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:55 INFO - Downloading/unpacking psutil>=0.7.1 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:57 INFO - Installing collected packages: psutil 07:53:57 INFO - Running setup.py install for psutil 07:53:57 INFO - building 'psutil._psutil_linux' extension 07:53:57 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 07:53:57 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 07:53:57 INFO - building 'psutil._psutil_posix' extension 07:53:57 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 07:53:57 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 07:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:57 INFO - Successfully installed psutil 07:53:57 INFO - Cleaning up... 07:53:57 INFO - Return code: 0 07:53:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:57 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:53:57 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 07:53:57 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 07:53:57 INFO - Using env: {'DISPLAY': ':0', 07:53:57 INFO - 'HOME': '/home/cltbld', 07:53:57 INFO - 'LANG': 'en_US.UTF-8', 07:53:57 INFO - 'LANGUAGE': 'en_US:en', 07:53:57 INFO - 'LOGNAME': 'cltbld', 07:53:57 INFO - 'MAIL': '/var/mail/cltbld', 07:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:57 INFO - 'MOZ_NO_REMOTE': '1', 07:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:57 INFO - 'NO_EM_RESTART': '1', 07:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:57 INFO - 'PWD': '/builds/slave/test', 07:53:57 INFO - 'SHELL': '/bin/bash', 07:53:57 INFO - 'SHLVL': '1', 07:53:57 INFO - 'TERM': 'linux', 07:53:57 INFO - 'TMOUT': '86400', 07:53:57 INFO - 'USER': 'cltbld', 07:53:57 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:57 INFO - '_': '/tools/buildbot/bin/python'} 07:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:54:00 INFO - Installing collected packages: mozsystemmonitor 07:54:00 INFO - Running setup.py install for mozsystemmonitor 07:54:00 INFO - Successfully installed mozsystemmonitor 07:54:00 INFO - Cleaning up... 07:54:00 INFO - Return code: 0 07:54:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:00 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:00 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 07:54:00 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 07:54:00 INFO - Using env: {'DISPLAY': ':0', 07:54:00 INFO - 'HOME': '/home/cltbld', 07:54:00 INFO - 'LANG': 'en_US.UTF-8', 07:54:00 INFO - 'LANGUAGE': 'en_US:en', 07:54:00 INFO - 'LOGNAME': 'cltbld', 07:54:00 INFO - 'MAIL': '/var/mail/cltbld', 07:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:00 INFO - 'MOZ_NO_REMOTE': '1', 07:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:00 INFO - 'NO_EM_RESTART': '1', 07:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:00 INFO - 'PWD': '/builds/slave/test', 07:54:00 INFO - 'SHELL': '/bin/bash', 07:54:00 INFO - 'SHLVL': '1', 07:54:00 INFO - 'TERM': 'linux', 07:54:00 INFO - 'TMOUT': '86400', 07:54:00 INFO - 'USER': 'cltbld', 07:54:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:00 INFO - '_': '/tools/buildbot/bin/python'} 07:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:00 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 07:54:00 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 07:54:00 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 07:54:00 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 07:54:00 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 07:54:00 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 07:54:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 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 07:54:02 INFO - Downloading docopt-0.6.1.tar.gz 07:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:03 INFO - Running setup.py install for blobuploader 07:54:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:03 INFO - Running setup.py install for requests 07:54:03 INFO - Running setup.py install for docopt 07:54:03 INFO - Successfully installed blobuploader requests docopt 07:54:03 INFO - Cleaning up... 07:54:03 INFO - Return code: 0 07:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:03 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')]} 07:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:03 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')]} 07:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:03 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:03 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 07:54:03 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 07:54:03 INFO - Using env: {'DISPLAY': ':0', 07:54:03 INFO - 'HOME': '/home/cltbld', 07:54:03 INFO - 'LANG': 'en_US.UTF-8', 07:54:03 INFO - 'LANGUAGE': 'en_US:en', 07:54:03 INFO - 'LOGNAME': 'cltbld', 07:54:03 INFO - 'MAIL': '/var/mail/cltbld', 07:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:03 INFO - 'MOZ_NO_REMOTE': '1', 07:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:03 INFO - 'NO_EM_RESTART': '1', 07:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:03 INFO - 'PWD': '/builds/slave/test', 07:54:03 INFO - 'SHELL': '/bin/bash', 07:54:03 INFO - 'SHLVL': '1', 07:54:03 INFO - 'TERM': 'linux', 07:54:03 INFO - 'TMOUT': '86400', 07:54:03 INFO - 'USER': 'cltbld', 07:54:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:03 INFO - '_': '/tools/buildbot/bin/python'} 07:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:03 INFO - Running setup.py (path:/tmp/pip-ac_203-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:03 INFO - Running setup.py (path:/tmp/pip-YqjG4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:03 INFO - Running setup.py (path:/tmp/pip-asoAoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:04 INFO - Running setup.py (path:/tmp/pip-q105yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:04 INFO - Running setup.py (path:/tmp/pip-UOeoXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:04 INFO - Running setup.py (path:/tmp/pip-wOnwyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:04 INFO - Running setup.py (path:/tmp/pip-3374oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:04 INFO - Running setup.py (path:/tmp/pip-gfTUV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:04 INFO - Running setup.py (path:/tmp/pip-AX_uIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:04 INFO - Running setup.py (path:/tmp/pip-7G4FM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:04 INFO - Running setup.py (path:/tmp/pip-H0B53b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:04 INFO - Running setup.py (path:/tmp/pip-Sbon_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:04 INFO - Running setup.py (path:/tmp/pip-rWFpdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:04 INFO - Running setup.py (path:/tmp/pip-u2e_82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:04 INFO - Running setup.py (path:/tmp/pip-PPPvd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:04 INFO - Running setup.py (path:/tmp/pip-Xc88w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:04 INFO - Running setup.py (path:/tmp/pip-QNX6GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:05 INFO - Running setup.py install for manifestparser 07:54:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Running setup.py install for mozcrash 07:54:05 INFO - Running setup.py install for mozdebug 07:54:05 INFO - Running setup.py install for mozdevice 07:54:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Running setup.py install for mozfile 07:54:05 INFO - Running setup.py install for mozhttpd 07:54:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Running setup.py install for mozinfo 07:54:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Running setup.py install for mozInstall 07:54:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:05 INFO - Running setup.py install for mozleak 07:54:05 INFO - Running setup.py install for mozlog 07:54:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Running setup.py install for moznetwork 07:54:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Running setup.py install for mozprocess 07:54:06 INFO - Running setup.py install for mozprofile 07:54:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Running setup.py install for mozrunner 07:54:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Running setup.py install for mozscreenshot 07:54:06 INFO - Running setup.py install for moztest 07:54:06 INFO - Running setup.py install for mozversion 07:54:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:06 INFO - Cleaning up... 07:54:06 INFO - Return code: 0 07:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:06 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')]} 07:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:06 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')]} 07:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:06 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:06 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 07:54:06 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 07:54:06 INFO - Using env: {'DISPLAY': ':0', 07:54:06 INFO - 'HOME': '/home/cltbld', 07:54:06 INFO - 'LANG': 'en_US.UTF-8', 07:54:06 INFO - 'LANGUAGE': 'en_US:en', 07:54:06 INFO - 'LOGNAME': 'cltbld', 07:54:06 INFO - 'MAIL': '/var/mail/cltbld', 07:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:06 INFO - 'MOZ_NO_REMOTE': '1', 07:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:06 INFO - 'NO_EM_RESTART': '1', 07:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:06 INFO - 'PWD': '/builds/slave/test', 07:54:06 INFO - 'SHELL': '/bin/bash', 07:54:06 INFO - 'SHLVL': '1', 07:54:06 INFO - 'TERM': 'linux', 07:54:06 INFO - 'TMOUT': '86400', 07:54:06 INFO - 'USER': 'cltbld', 07:54:06 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:06 INFO - '_': '/tools/buildbot/bin/python'} 07:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:07 INFO - Running setup.py (path:/tmp/pip-XcemFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:07 INFO - Running setup.py (path:/tmp/pip-WHiytv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:07 INFO - Running setup.py (path:/tmp/pip-zeMAZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:07 INFO - Running setup.py (path:/tmp/pip-LlRdJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:07 INFO - Running setup.py (path:/tmp/pip-ubomPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:07 INFO - Running setup.py (path:/tmp/pip-CHsX6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:07 INFO - Running setup.py (path:/tmp/pip-gspTr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:07 INFO - Running setup.py (path:/tmp/pip-akR9uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:07 INFO - Running setup.py (path:/tmp/pip-sduzbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:07 INFO - Running setup.py (path:/tmp/pip-ZIuNfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:07 INFO - Running setup.py (path:/tmp/pip-qUzovf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:07 INFO - Running setup.py (path:/tmp/pip-mkaha0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:07 INFO - Running setup.py (path:/tmp/pip-vUBaFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:07 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)) 07:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:07 INFO - Running setup.py (path:/tmp/pip-HZjC1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:08 INFO - Running setup.py (path:/tmp/pip-sgeRXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:08 INFO - Running setup.py (path:/tmp/pip-_n9KnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:08 INFO - Running setup.py (path:/tmp/pip-emqJqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:08 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)) 07:54:08 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)) 07:54:08 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)) 07:54:08 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)) 07:54:08 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)) 07:54:08 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)) 07:54:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:08 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 07:54:08 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 07:54:08 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 07:54:08 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 07:54:08 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 07:54:08 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 07:54:10 INFO - Downloading blessings-1.6.tar.gz 07:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:10 INFO - Installing collected packages: blessings 07:54:10 INFO - Running setup.py install for blessings 07:54:10 INFO - Successfully installed blessings 07:54:10 INFO - Cleaning up... 07:54:10 INFO - Return code: 0 07:54:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:10 INFO - Reading from file tmpfile_stdout 07:54:10 INFO - Current package versions: 07:54:10 INFO - argparse == 1.2.1 07:54:10 INFO - blessings == 1.6 07:54:10 INFO - blobuploader == 1.2.4 07:54:10 INFO - docopt == 0.6.1 07:54:10 INFO - manifestparser == 1.1 07:54:10 INFO - mozInstall == 1.12 07:54:10 INFO - mozcrash == 0.17 07:54:10 INFO - mozdebug == 0.1 07:54:10 INFO - mozdevice == 0.48 07:54:10 INFO - mozfile == 1.2 07:54:10 INFO - mozhttpd == 0.7 07:54:10 INFO - mozinfo == 0.9 07:54:10 INFO - mozleak == 0.1 07:54:10 INFO - mozlog == 3.1 07:54:10 INFO - moznetwork == 0.27 07:54:10 INFO - mozprocess == 0.22 07:54:10 INFO - mozprofile == 0.28 07:54:10 INFO - mozrunner == 6.11 07:54:10 INFO - mozscreenshot == 0.1 07:54:10 INFO - mozsystemmonitor == 0.0 07:54:10 INFO - moztest == 0.7 07:54:10 INFO - mozversion == 1.4 07:54:10 INFO - psutil == 3.1.1 07:54:10 INFO - requests == 1.2.3 07:54:10 INFO - wsgiref == 0.1.2 07:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:10 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')]} 07:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:10 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')]} 07:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:10 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:10 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 07:54:10 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 07:54:10 INFO - Using env: {'DISPLAY': ':0', 07:54:10 INFO - 'HOME': '/home/cltbld', 07:54:10 INFO - 'LANG': 'en_US.UTF-8', 07:54:10 INFO - 'LANGUAGE': 'en_US:en', 07:54:10 INFO - 'LOGNAME': 'cltbld', 07:54:10 INFO - 'MAIL': '/var/mail/cltbld', 07:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:10 INFO - 'MOZ_NO_REMOTE': '1', 07:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:10 INFO - 'NO_EM_RESTART': '1', 07:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:10 INFO - 'PWD': '/builds/slave/test', 07:54:10 INFO - 'SHELL': '/bin/bash', 07:54:10 INFO - 'SHLVL': '1', 07:54:10 INFO - 'TERM': 'linux', 07:54:10 INFO - 'TMOUT': '86400', 07:54:10 INFO - 'USER': 'cltbld', 07:54:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:10 INFO - '_': '/tools/buildbot/bin/python'} 07:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 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)) 07:54:10 INFO - Cleaning up... 07:54:10 INFO - Return code: 0 07:54:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:10 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')]} 07:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:10 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')]} 07:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:10 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:10 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 07:54:10 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 07:54:10 INFO - Using env: {'DISPLAY': ':0', 07:54:10 INFO - 'HOME': '/home/cltbld', 07:54:10 INFO - 'LANG': 'en_US.UTF-8', 07:54:10 INFO - 'LANGUAGE': 'en_US:en', 07:54:10 INFO - 'LOGNAME': 'cltbld', 07:54:10 INFO - 'MAIL': '/var/mail/cltbld', 07:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:10 INFO - 'MOZ_NO_REMOTE': '1', 07:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:10 INFO - 'NO_EM_RESTART': '1', 07:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:10 INFO - 'PWD': '/builds/slave/test', 07:54:10 INFO - 'SHELL': '/bin/bash', 07:54:10 INFO - 'SHLVL': '1', 07:54:10 INFO - 'TERM': 'linux', 07:54:10 INFO - 'TMOUT': '86400', 07:54:10 INFO - 'USER': 'cltbld', 07:54:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:10 INFO - '_': '/tools/buildbot/bin/python'} 07:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:11 INFO - Downloading/unpacking jsonschema 07:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:13 INFO - warning: no files found matching '*.txt' 07:54:13 INFO - no previously-included directories found matching 'build' 07:54:13 INFO - no previously-included directories found matching 'dist' 07:54:13 INFO - no previously-included directories found matching '.git*' 07:54:13 INFO - Installing collected packages: jsonschema, functools32 07:54:13 INFO - Running setup.py install for functools32 07:54:13 INFO - warning: no files found matching '*.txt' 07:54:13 INFO - no previously-included directories found matching 'build' 07:54:13 INFO - no previously-included directories found matching 'dist' 07:54:13 INFO - no previously-included directories found matching '.git*' 07:54:13 INFO - Successfully installed jsonschema functools32 07:54:13 INFO - Cleaning up... 07:54:13 INFO - Return code: 0 07:54:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:13 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 0x7fe3eff32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', '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 07:54:13 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 07:54:13 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 07:54:13 INFO - Using env: {'DISPLAY': ':0', 07:54:13 INFO - 'HOME': '/home/cltbld', 07:54:13 INFO - 'LANG': 'en_US.UTF-8', 07:54:13 INFO - 'LANGUAGE': 'en_US:en', 07:54:13 INFO - 'LOGNAME': 'cltbld', 07:54:13 INFO - 'MAIL': '/var/mail/cltbld', 07:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:13 INFO - 'MOZ_NO_REMOTE': '1', 07:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:13 INFO - 'NO_EM_RESTART': '1', 07:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:13 INFO - 'PWD': '/builds/slave/test', 07:54:13 INFO - 'SHELL': '/bin/bash', 07:54:13 INFO - 'SHLVL': '1', 07:54:13 INFO - 'TERM': 'linux', 07:54:13 INFO - 'TMOUT': '86400', 07:54:13 INFO - 'USER': 'cltbld', 07:54:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:13 INFO - '_': '/tools/buildbot/bin/python'} 07:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:13 INFO - Downloading/unpacking flake8 07:54:13 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 07:54:13 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 07:54:13 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 07:54:13 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 07:54:13 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 07:54:13 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 07:54:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:54:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:54:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:15 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 07:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:16 INFO - no previously-included directories found matching 'docs/_build' 07:54:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:54:16 INFO - Running setup.py install for pep8 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:16 INFO - no previously-included directories found matching 'docs/_build' 07:54:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:54:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:54:16 INFO - Cleaning up... 07:54:16 INFO - Return code: 0 07:54:16 INFO - Running post-action listener: _resource_record_post_action 07:54:16 INFO - Running post-action listener: _start_resource_monitoring 07:54:16 INFO - Starting resource monitoring. 07:54:16 INFO - ##### 07:54:16 INFO - ##### Running install step. 07:54:16 INFO - ##### 07:54:16 INFO - Running pre-action listener: _resource_record_pre_action 07:54:16 INFO - Running main action method: install 07:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:16 INFO - Reading from file tmpfile_stdout 07:54:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:16 INFO - Reading from file tmpfile_stdout 07:54:16 INFO - Output received: 07:54:16 INFO - Usage: mozinstall [options] installer 07:54:16 INFO - Options: 07:54:16 INFO - -h, --help show this help message and exit 07:54:16 INFO - -d DEST, --destination=DEST 07:54:16 INFO - Directory to install application into. [default: 07:54:16 INFO - "/builds/slave/test"] 07:54:16 INFO - --app=APP Application being installed. [default: firefox] 07:54:16 INFO - mkdir: /builds/slave/test/build/application 07:54:16 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'] 07:54:16 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 07:54:32 INFO - Reading from file tmpfile_stdout 07:54:32 INFO - Output received: 07:54:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:54:32 INFO - Running post-action listener: _resource_record_post_action 07:54:32 INFO - ##### 07:54:32 INFO - ##### Running run-tests step. 07:54:32 INFO - ##### 07:54:32 INFO - Running pre-action listener: _resource_record_pre_action 07:54:32 INFO - Running main action method: run_tests 07:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:32 INFO - Python 2.7.3 07:54:32 INFO - Return code: 0 07:54:32 INFO - grabbing minidump binary from tooltool 07:54:32 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')]} 07:54:32 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 0x26bc410>, '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 0x26bd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bd7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:32 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 07:54:32 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 07:54:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:32 INFO - Return code: 0 07:54:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:54:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:54:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:54:33 INFO - Return code: 0 07:54:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:54:33 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:54:33 INFO - Using env: {'DISPLAY': ':0', 07:54:33 INFO - 'HOME': '/home/cltbld', 07:54:33 INFO - 'LANG': 'en_US.UTF-8', 07:54:33 INFO - 'LANGUAGE': 'en_US:en', 07:54:33 INFO - 'LOGNAME': 'cltbld', 07:54:33 INFO - 'MAIL': '/var/mail/cltbld', 07:54:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:33 INFO - 'MOZ_NO_REMOTE': '1', 07:54:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:33 INFO - 'NO_EM_RESTART': '1', 07:54:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:33 INFO - 'PWD': '/builds/slave/test', 07:54:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:33 INFO - 'SHELL': '/bin/bash', 07:54:33 INFO - 'SHLVL': '1', 07:54:33 INFO - 'TERM': 'linux', 07:54:33 INFO - 'TMOUT': '86400', 07:54:33 INFO - 'USER': 'cltbld', 07:54:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952', 07:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:33 INFO - '_': '/tools/buildbot/bin/python'} 07:54:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:54:33 INFO - mozversion application_buildid: 20160427071021 07:54:33 INFO - mozversion application_changeset: 0a2e98e3e736ac03f53cf844113b2029213e4af4 07:54:33 INFO - mozversion application_display_name: Nightly 07:54:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:33 INFO - mozversion application_name: Firefox 07:54:33 INFO - mozversion application_remotingname: firefox 07:54:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:54:33 INFO - mozversion application_vendor: Mozilla 07:54:33 INFO - mozversion application_version: 49.0a1 07:54:33 INFO - mozversion platform_buildid: 20160427071021 07:54:33 INFO - mozversion platform_changeset: 0a2e98e3e736ac03f53cf844113b2029213e4af4 07:54:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:54:33 INFO - mozversion platform_version: 49.0a1 07:54:33 INFO - using testdate: 1461768873 07:54:33 INFO - actual date: 1461768873 07:54:33 INFO - starting webserver on 'localhost:39862' 07:54:33 INFO - SUITE-START | Running 2 tests 07:54:33 INFO - TEST-START | dromaeo_css 07:54:33 INFO - operating with platform_type : linux_ 07:54:33 INFO - Initialising browser for dromaeo_css test... 07:54:33 INFO - TEST-INFO | started process 28164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzHZOjw/profile http://localhost:39862/getInfo.html) 07:54:37 INFO - PROCESS | 28164 | __metrics Screen width/height:1600/1200 07:54:37 INFO - PROCESS | 28164 | colorDepth:24 07:54:37 INFO - PROCESS | 28164 | Browser inner width/height: 1024/697 07:54:37 INFO - PROCESS | 28164 | __metrics 07:54:38 ERROR - PROCESS | 28164 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:54:39 INFO - TEST-INFO | 28164: exit 0 07:54:39 INFO - Browser initialized. 07:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:39 INFO - TEST-INFO | started process 28243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzHZOjw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:51 INFO - PROCESS | 28243 | RSS: Main: 156631040 07:54:51 INFO - PROCESS | 28243 | 07:55:43 INFO - PROCESS | 28243 | 1461768943076 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] 07:57:54 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39862/tests/dromaeo/cssquery-ext.html) 07:57:55 INFO - PROCESS | 28243 | RSS: Main: 264347648 07:57:55 INFO - PROCESS | 28243 | 08:00:58 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-ext.html (next: http://localhost:39862/tests/dromaeo/cssquery-jquery.html) 08:00:58 INFO - PROCESS | 28243 | RSS: Main: 238329856 08:00:58 INFO - PROCESS | 28243 | 08:04:00 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39862/tests/dromaeo/cssquery-mootools.html) 08:04:01 INFO - PROCESS | 28243 | RSS: Main: 239689728 08:04:01 INFO - PROCESS | 28243 | 08:07:03 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39862/tests/dromaeo/cssquery-prototype.html) 08:07:03 INFO - PROCESS | 28243 | RSS: Main: 230383616 08:07:03 INFO - PROCESS | 28243 | 08:10:06 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39862/tests/dromaeo/cssquery-yui.html) 08:10:07 INFO - PROCESS | 28243 | RSS: Main: 215109632 08:10:07 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | Cycle 1(1): loaded http://localhost:39862/tests/dromaeo/cssquery-yui.html (next: http://localhost:39862/tests/dromaeo/cssquery-dojo.html) 08:13:10 INFO - PROCESS | 28243 | RSS: Main: 269852672 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | __start_tp_report 08:13:10 INFO - PROCESS | 28243 | _x_x_mozilla_page_load 08:13:10 INFO - PROCESS | 28243 | _x_x_mozilla_page_load_details 08:13:10 INFO - PROCESS | 28243 | |i|pagename|runs| 08:13:10 INFO - PROCESS | 28243 | |0;dojo.html;2615.50305441966;2686;2686.4761371532536;2695.7034726180104;2720.523908316044;4608.815647374101;4672.906541869161;4675.532446755323;4688.038952014837;4711.2462006078995;4651.279051746977;4663.417072865892;4664.8134074637055;4756.453007904092;4758.048390321941;4287.8070486828165;4290;4334.696571240014;4362.5637436256275;4443.511213766483;4361.236783562879;4388.1223755249075;4398.934015989763;4439.089986552765;4459.888502787424;4188.68584856137;4259.787010649455;4315.050688848449;4318.611324980767;4387.210302145612;4274.957250427518;4324.156789426063;4334.696571240014;4337.392765012901;4372.431583894106;4273.636740876998;4298.290782020994;4313.590208930146;4322.243607368698;4346.304591265414;4506.819727210907;4538.228501154778;4585.243434833248;4616.5152658970665;4630.166570017395;4957.628177886673;4975.029869175512;4975.552200301954;4979.053979743873;5013.623978201613;4964.404271487409;5001.224810154432;5003.299538064637;5003.324551185616;5053.418856831438;4626.930596041028;4664.930026049612;4703.247480403119;4776.283557466408;4779.0680817241;5070.062038522885;5072.087024335581;5075.695458272442;5086.669366491166;5100.948990510122;4851.2723091535845;4865.0999565079865;4866.635002374836;4873.31773551703;4926.729029903389;4884.633652476078;5048.268001139814;5072.416672082758;5108.642395032312;5115.616328775357;4916.631252656065;4943.555080042814;4945.406551213878;4950.2822090796635;5000.099982003274;4827.975860120677;4916.385451818523;4924.384451943507;4927.531884470969;4968.975155124202;4156.625903668684;4160.043190066242;4232.174725928476;4239.788010599457;4241.448611680462;3638.472421498868;3664.3953747631876;3664.5052917855746;3696.6857817085847;3704.9629503705155;4325.394444777734;4328.913421731548;4334.523202447728;4336.306191009423;4376.518582955872;4886.267059940967;5006.249062640561;5037.042961837239;5052.141136006888;5081.949180508222;4313.180495705806;4316.115196384733;4342.891427714332;4348.065165989327;4389.473263208435;4484.641228701696;4492.034212644297;4495.662825288116;4498.887527811831;4553.977230113828;4644.535546445329;4690.6012988895645;4736.692115012514;4755.881102972453;4770.713757174581;4972.229304457815;4992.700437973734;4998.2002879539095;5004.474530174425;5056.721880296619;4712.764361781966;4754.928676069931;4761.809527618856;4767.308740232577;4820.180569303297;4769.952300476951;4968.552830245295;4988.42633097184;5023.874403139951;5042.042012017705;4977.850664480072;5002.749862506787;5006.774695138801;5011.123053465702;5058.3929928408825;4756.7145971241835;4877.12211801879;4878.536539028786;4878.829240976549;4925.950740492693;4795.976020119877;4825.252085926687;4853.247746599282;4870.464248932543;4905.337779399735;4816.831410900601;4826.782794774173;4836.419629644465;4840.903181936412;4881.658283920092;4787.3776409066595;4873.805047798191;4919.139150648551;4941.876453088702;4997.950020499894;4761.833335833229;4784.760761961818;4788.377510923558;4808.735519546459;4837.661363704507 08:13:10 INFO - PROCESS | 28243 | |1;ext.html;565.8245943757436;589.5902347868231;612.727336335331;622.0886401421917;627.3068259573174;27573.58639620407;27773;28271;28316.716832831666;28627.856860715692;33071.33857322858;33350.16624584381;33915.66084339156;34126;34175.82912085436;7446.143693475252;7659.540427574336;7666.3866890648615;7666.7316643917475;7669.079710434756;6996.685149168275;7469.365103966169;7621.047369078865;7626.618669066552;9308.255339572852;9530;9690.224782017456;9692.854607180898;9694.466804325759;9694.854577181313;9517.143457088861;9626.133647971681;9636.662716804949;9648.662296819577;9649.276304277137;9456.574454149511;9562.521873906346;9575.664851730226;9582.616695332248;9588;31309.843450782828;35440.822795885855;35537.1115722109;35581;35643.82178089119;3153.369326134782;3166.0343595203453;3187.6971687689634;3188.7289580385695;3246.2533617267923;27318.180454586392;27333.316667083283;27506.449871002667;28220.717792822015;28439.431211375864;3407.8296085195643;3414.590249170091;3473.166440054394;3547.5033495310677;3560.4659301104784;200446;200813;201016;201666.9249883759;202273.99999999852;48410;48509.75745121252;48548.51451485511;48560.27159592609;48645.75677121663;46489;47040.5295947043;47055.5294447058;47117.293240601415;47121.29318060232;13588.796168057486;13769.449222031208;13780.379882905294;13784.931075344559;13786;10182.796344073226;10214.948925255327;10218.080372766486;10225.43760093202;10227.181825453947;14964;15776.842231577766;15824.446144385121;15825.920870395574;15881.602959926095;5908.497777688859;6096.481799047042;6155.384461553898;6197.411245931629;6233.906491402633;883.969061082859;884.8761173435724;967.908048735369;995.6963126246565;1053.562771449855;25102;26069.60895586568;26410.207693769218;26483;26777.598336024974;910.2035718746097;994.2841154368842;1024.0374048394485;1031.4017869635593;1077.1490522487147;13555.254461004739;14104.576862694135;14302.356393962296;14356.425742970374;14366.35351409189;241919;245376;247576;248780;259700;43861;44063.55936440659;44170.11659766787;44205;44220.336694949605;1152.383474840956;1247.1207798502217;1258.7545428641326;1268.4482250221183;1280.5582074184392;23952;26530.204093877215;27032.324191894575;27123.728762712908;27205.86397068002;38261;38349.808250958566;38375.42436863393;38393.23213535658;38542.614573853905;194805;197159;197212;197699;197750;23148.421289467897;24406.87796561006;24429.755702443457;24434.877825610758;24443;37606.62393376031;37687.81156094202;37894.62105378911;38384.42423363707;38532.80733596314;33106.83446582848;33385.499217512246;33543.49684754682;33705;33794.3241135171;32495.512567311038;32903.34193316168;33131.66868331382;33258.83370583132;33306.335493160004;33083.50374744429;33240.16899577433;33330.500042499865;33341.83329083339;33603;28760.280992975342;29840.552391713707;29972.100836974925;30003.54994675038;30086.849565752906;22841.657375139053;23433;23558.175463858683;23748.287551373487;23759.287221383387 08:13:10 INFO - PROCESS | 28243 | |2;jquery.html;379.3229086081345;391.8623906589554;392.5426877687496;396.1897918756144;403.5903557888743;15157.696846063072;15344.539663810103;15693.686126277467;15712.842871571294;15723.764143537841;15392.538223853275;15907.92046039771;16159;16247.83752162478;16266.861319707625;4818.445878723948;4994.375703037121;5015.774290156934;5021.096202683534;5022.271770593262;4984.626153038536;5021.723805190732;5031.874203144914;5050.595952323805;5071.492850714917;4949.455559888409;5022.648414610979;5022.799088036474;5051.1413059779925;5093.650182701587;5014.52362025607;5034.597232221432;5038.949610503884;5102.438731739506;5428.104362780136;5270.92093618596;5300.443453437372;5319.920201196946;5340.172273297645;5344.0915044442145;11437.59968401102;12001.699957501045;12035.27788332694;12051;18824.81175188258;1916.252661462031;1973.4572992427054;2131.2007997001124;2234.2515257388795;2236.317923033474;8979.416337938013;9224.53877306132;9382.10869967352;10656.254062215648;12287.69280767988;1652.4464304458022;1674.5060207238894;1713.9314427422887;1734.1156010434643;1772.7784026996626;57762;60909.6954515229;61255.387446125416;61482.38517614811;61570.38429615691;9913.355631883904;10005.249606279558;10063.245256605784;10091.798164036825;10104.595816167272;13761.449542018407;13958.930205348908;13981.300934953211;13989.3704783285;13997.790033149511;7102.112235970504;7155.89266161008;7188.137423509108;7281.817954551073;7313.561186328731;6728.981305608298;6760.763373281911;6762.628055456997;6856.657167141623;6897.827554311082;4339.63113135387;4378.64970802335;4399.1641588098155;4428.6678499112695;4502.212112880298;1846.9722954155698;1868.1593283022694;1876.6434377468238;1887.292265400475;1911.858718235585;886.4459712679575;890.3189060368823;900.0774206438452;903.75146834621;938.648006997376;15505.147216903179;15749;15813.920930395274;16419.096949667644;16591.25339359732;892.205936716323;896.4486840592988;901.756525738047;950.0689324462066;952.0764858087643;8886.73339799807;9272.443653380818;9357.859632105525;9363.578638961262;9518.666846660333;355778;361059;362764;363586;364709;62052.68973655103;63748.68125659435;66465;66647.66676166588;66793.66603167051;939.6053657463882;942.5193151492651;948.4830767231875;955.6798472511787;963.5278713430368;14126.717465650834;14261.786073209118;14331.570052898429;14358.353874075483;14799.482018129314;28538.57192142078;30205.244868878453;30891;31333.216669583442;32082.839585802856;35605.46591801177;36101.81949090238;36597.63402366049;43012;43018.13963720771;7362.300581444754;7444;7632.809179770328;7689.923100769144;7744.7676569703;9089.681861135094;11229.71925701864;11405.830265645143;11412.657620271406;11481.425928703698;9395.201407880133;9648.035196480296;9694.272929530172;9759.463229522444;10007.749806254902;9648;10090.39457632515;10139.594416223563;10147.695569132939;10234.130098941674;9308.162265396148;9384.155426011692;9585.520723963913;9602.807943840944;10034.046765557261;7485.887711684438;7486.139094004259;7613.695452181851;7638.732644357421;7643.57960312166;7632.465727399029;8817;10035.316652699768;10111.7472063199;10145.594176232868 08:13:10 INFO - PROCESS | 28243 | |3;mootools.html;1275.7257189704212;1443.1269082205263;1479.312119864263;1598.7362085255927;1760.2255007796578;6582.243042050166;7215.2063273039985;7345.375643070332;7372.447066470009;7376.557406555604;7058.329458701415;7232.566046037228;7234.565926044441;7244.130704315489;7251.238619944896;2209.668549717543;2213.2474958514103;2224.232639739287;2237.7538470768204;2238.932832015034;2138.967915481269;2195.220696652689;2211.159759291475;2212.413710366754;2236.3738153317017;2224.9332520024427;2227.766084561122;2233;2235.5864165129424;2265.4449659833363;2142.046789178816;2178.2485042660337;2183.5960347335795;2183.759786423492;2189.200941656292;2139.326112274644;2143.967840482394;2148.957020859574;2154.310620601408;2155.094860158737;7309.634518274065;7371.88942165868;7391.741289054911;7395.260473952616;7423.4061275097865;4463.68754187207;4636.11913736389;4645;4645.094206629708;4650.162970665279;2902.912912612625;2930.2674331417147;2985.6566494853155;3013.3973205358798;3048.496997995328;915.8626206069076;940.586142097475;944.6788092048668;948.3598570964572;951.1867353412802;9891.851622225673;9990.05094516027;9995.550200241007;9999.700008999742;10015.248856335731;4145.626893579532;4188.308929026676;4266.893327666833;4281.614654681093;4290.356446532983;7969.601519923981;8100.756977290691;8103.473274237156;8106.837863242702;8123.593820309079;4534.274516077412;4604.769761511911;4605.078984203173;4609.1703493371515;4611.469680986663;3789.4694742736037;4155.459790227251;4244.639205667491;4328.61042506176;4347.413099231563;3368.79787212768;3386.204242003127;3436.398630239748;3452.6202117767025;3457.8098204598987;1082.7780305037447;1084.815581351172;1087.4617064553097;1094.6223552874246;1094.655183617158;838.3879767769563;839.5550358310105;851.7487341234227;870.629982257538;871.5467956662627;5004.799808007711;5011.899762004739;5028.346314979102;5211.765470553834;5343.225232341289;880.6873559886276;881.1188811188811;891.148952750122;905.538175530471;950.9714708558754;3243.2540515681526;3308.9503657445157;3391.236971681352;3393.100828280508;3402.8128452935325;8472.830543389098;9039;9057.09429057089;9075.13786190311;9089.909100908906;8818.426802257833;8857.468551886908;8902.910970890338;8937.865932011026;8938.553072346356;6587.9670601646685;6857.417119544894;6930;7097.538659987084;7188.101487314086;5236.816711415082;5247.08176069194;5249.7375131242525;5374.758135883816;5390.919136212881;8218.301444377295;8438.915610843813;8724.127587241224;8790.42862213954;8813.118688131392;8769.342299327449;8783.91216087831;8943.955280223558;8957.955210223907;9014.864777028219;5910.763569457174;6337.207849018872;6563.474922006132;6572.76995305162;6746.392824645805;7065.434765218873;7142.142942846684;7158.212596614472;7200.855982880418;7203.315685009916;6410.5192110592825;6658.467322614082;6663.466922646274;6751.56114852533;6762.830929226809;6487.578307410004;6503.219613646393;6513.478921686348;6538.705758240795;6611.933880661324;6026.337102918587;6087.634741915499;6101.267847858286;6102.786402475892;6108.17539632144;4299.505556860876;4367.694261401672;4387.758673273001;4503.842365517191;4510.097980403998;4504.414426124583;4509.842155524541;4548.067646132468;4665.346851440733;4667.789949452351 08:13:10 INFO - PROCESS | 28243 | |4;prototype.html;303.7175426853026;307.14613374817986;310.6924145096354;319.5606041692672;323.10822130918666;4667.743274119922;4697.2719228519545;4707.646926480515;4736.455307639618;4738.15212067294;4644.860654180372;4652.534746525345;4652.837150699726;4654.557817007388;4656.720596764197;3591.2637909228547;3670.6696397324235;3711.647393497627;3764.2659681362147;3797.563280222782;3731.347014272505;3752.3058234226755;3757.5678796938428;3765.4351847222997;3791.563970143441;3540.716742660594;3705.5182826232685;3720.683741881943;3721.1441368485266;3735.9813200934095;3632.527771389716;3743.850245990157;3755.586885442599;3756.2675278320876;3764.3224219640456;3339.248669049469;3350.095474221971;3366.309906469168;3373.612034616026;3380.594328680574;4505.842295519674;4511.345854851028;4514.277715565527;4524.09518096382;4524.185646583614;3971.245463361952;4175.874723758292;4195.769232692201;4276.401303817468;4283.593058659422;4908.9754551227015;4924.113659541281;4926.778294976699;4938.358013458227;4945.7774400152075;3537.4340105582983;3552.3605750964816;3556.751027428081;3564.2515071834946;3581.6776490116013;5041.143525203222;5082.872928176788;5115.897682046376;5151.845444636667;5184.948150518522;3583.6595523425235;3616.2405894762396;3619.3123306571665;3637.1630128499814;3637.727170462226;3662.340778659867;3668.99142702981;3691.187938653492;3691.2063906259746;3706.4810926470313;4134.214499245134;4172.812223449952;4176.895577610523;4179.6238338549065;4193.769342686121;4628.884277893012;4919.4834542373255;4948.802047918115;4967.254911763264;4977.129002424561;1331.2212355771787;1334.9132306400054;1338.4044100375434;1340.1155237543176;1341;848.966041358351;893.8659201119884;903.8779764731677;913.488446469979;914.8078903430221;4636.095961287584;4656.4412270527755;4656.906861862743;4663.393758811333;4683.789229484613;5372.892542149135;5384.6499977501335;5406.2701535292235;5423.186522021729;5439.619226654176;4522.25382811839;4617.79219935097;4632.467266264355;4651.2557990721325;4673.042026384583;2821.8730157142977;2841.758450531687;2865.0545320044334;2871.9425611488073;2877.3525956659582;5092.9236061459105;5096.770645320969;5100.923486147711;5119.769610367543;5129;5310.769476819745;5432.158015507603;5453.918191227135;5469;5504.724763761796;5109.489051094935;5114.312276948598;5142.331496905378;5148.742562871841;5150.690958542425;5355.259540649226;5377;5400.135978243462;5401.2168235606405;5429.185622156708;5105.617078719037;5263.105272103675;5282.418933917343;5286.62993590445;5287.391949925808;5041;5117.8464646060675;5149.253358262956;5159.561437277874;5171.715555644476;3834.654881060718;3837.7505462144873;3841.9231615366975;3846.653801157909;3848.4419759134207;5286.62993590445;5383.461653834742;5385.75764090609;5392.137258038695;5410.862709229754;5134.332536770196;5188.195829646411;5188.896222075613;5203.115470370122;5220.321358223407;5010.749462526932;5188.325517682677;5190.143626301769;5203.219517072469;5211;4638.6752927294765;5111.156659151198;5135.614828887923;5136.2552429898205;5144.768485418091;4773.880652983703;4871.805127794849;4893.143699852582;4915.729634870117;4926.162552366178;4844.975775121102;4868.513148685103;4896.216605343128;4914.975425122851;4920.630952678635 08:13:10 INFO - PROCESS | 28243 | |5;yui.html;671.979840604782;680.8876535371664;697.1912581405569;724.6195747232703;741.6921977379387;11335.489902954367;11894.226875253113;13739.381727822247;14155.787663185061;14191.148531088142;13442.39509222085;13507.594772156826;13522.391492382842;13526.120802147878;13585.456581736718;639.4947991087035;791.1850793682487;804.485129517108;810.8256724804166;814.1004190369645;817.1256755271861;822.3955392786297;823.0945959444623;823.7034667519719;824.3570015388007;850.4259624753298;860.3590325207729;860.789106668867;860.9913900861005;861.4701958295666;666.7433038280298;825.0511911301991;848.7793173774833;849.7153453592992;852.3990586636406;616.5191150902303;617.4566381584222;617.5677026081761;618.5700937848197;618.9350118237566;12522.561710340095;12579.874201257962;12589.370531473389;12591.685207869876;12603.684907877285;11402.600908968147;11684.532618695242;11898.22661526998;11956.641300760992;12569.685757856036;9461.290403219786;9544.236461083166;9683;9707.320487565874;9786.706398807975;3269.29710112327;3327.45097058985;3396.9490457643155;3453.1539772755837;3474.704650104719;43162.35256471155;43171.352429713894;43228.78385608052;43572;43981.78009109966;9662.323637345458;9662.71011869645;9700.369475984038;9749.756256093655;9789.9021009789;16526.917365413097;16642.667146657;16661.91669041647;16720.331186752635;16724.41464548759;6633.137692100093;6679.365460281266;6716.966415167893;6743.055972163901;6795.932040679629;3739.4390841373465;3786.261678972629;3806.676432503268;3904.6095390460728;3912.3349030664854;2852.301186209392;2924.225080353708;2931.3697555025774;2931.8240905545736;2934.4864648686394;498.61606562946326;503.3129777853204;514.2697369734985;515.2194425445379;515.8632962265003;455.9270516717309;470.1138354202353;540.5486418840234;564.7769131193156;566.7364675425947;7549.7357592483995;7641.176177919321;7647;7764.145943946161;7864.685412583547;572.4161355417451;583.6468936293567;593.2791658135386;615.0159744409;640.5132099604334;3538.8584456621447;3645.6354364563863;3698.7635818658673;3734.607866174067;3785.09157802131;45838.31242531365;47233.52766472291;48830.51169488331;50558.49441505538;50904.49095509072;41160.176796464504;42537.57462425398;42575.7871210642;42901;43248.567514325085;39825.40261896074;40008.599914000486;40327.798361008005;40566.39150412687;40977.975550611474;7611.2769286917655;7662.463627546018;7940.444168908121;7964.482308649919;8147.551884646165;28473.857630711715;28848.278793030342;29160.979365722098;29695.73346931879;30563.2359191022;35440.29119417546;35804.4629330555;35859.282814343045;37091.44362834613;40037.39943900786;9248.861267080865;10246.38521688701;10303.484825758833;10434.530446130095;10595.841062383915;10051.69844904654;10294.279400442198;10431.739206519898;11874.584389546324;12593.748125037264;8265.586720664063;10093.545790439595;11010.174236932422;11143.997040266415;11592;11220.66338009861;11243.269187502787;11280.2667826591;11489.712757180803;11719.121065919919;9842.852357214791;9998.400095994264;10150.086492215441;10202.897971020195;10259;9302.906970930475;9734.513274336396;9755.463449510346;10281.897181028095;10315.587376504856;9194.770130746785;9607.56765945548;9688.467134307399;9771.12059914611;9779.364341317792 08:13:10 INFO - PROCESS | 28243 | __end_tp_report 08:13:10 INFO - PROCESS | 28243 | __start_cc_report 08:13:10 INFO - PROCESS | 28243 | _x_x_mozilla_cycle_collect,1085 08:13:10 INFO - PROCESS | 28243 | __end_cc_report 08:13:10 INFO - PROCESS | 28243 | __startTimestamp1461769990434__endTimestamp 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | ------- Summary: start ------- 08:13:10 INFO - PROCESS | 28243 | Number of tests: 6 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#0] dojo.html Cycles:165 Average:4626.31 Median:4767.31 stddev:471.57 (9.9%) stddev-sans-first:445.85 08:13:10 INFO - PROCESS | 28243 | Values: 2615.5 2686.0 2686.5 2695.7 2720.5 4608.8 4672.9 4675.5 4688.0 4711.2 4651.3 4663.4 4664.8 4756.5 4758.0 4287.8 4290.0 4334.7 4362.6 4443.5 4361.2 4388.1 4398.9 4439.1 4459.9 4188.7 4259.8 4315.1 4318.6 4387.2 4275.0 4324.2 4334.7 4337.4 4372.4 4273.6 4298.3 4313.6 4322.2 4346.3 4506.8 4538.2 4585.2 4616.5 4630.2 4957.6 4975.0 4975.6 4979.1 5013.6 4964.4 5001.2 5003.3 5003.3 5053.4 4626.9 4664.9 4703.2 4776.3 4779.1 5070.1 5072.1 5075.7 5086.7 5100.9 4851.3 4865.1 4866.6 4873.3 4926.7 4884.6 5048.3 5072.4 5108.6 5115.6 4916.6 4943.6 4945.4 4950.3 5000.1 4828.0 4916.4 4924.4 4927.5 4969.0 4156.6 4160.0 4232.2 4239.8 4241.4 3638.5 3664.4 3664.5 3696.7 3705.0 4325.4 4328.9 4334.5 4336.3 4376.5 4886.3 5006.2 5037.0 5052.1 5081.9 4313.2 4316.1 4342.9 4348.1 4389.5 4484.6 4492.0 4495.7 4498.9 4554.0 4644.5 4690.6 4736.7 4755.9 4770.7 4972.2 4992.7 4998.2 5004.5 5056.7 4712.8 4754.9 4761.8 4767.3 4820.2 4770.0 4968.6 4988.4 5023.9 5042.0 4977.9 5002.7 5006.8 5011.1 5058.4 4756.7 4877.1 4878.5 4878.8 4926.0 4796.0 4825.3 4853.2 4870.5 4905.3 4816.8 4826.8 4836.4 4840.9 4881.7 4787.4 4873.8 4919.1 4941.9 4998.0 4761.8 4784.8 4788.4 4808.7 4837.7 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#1] ext.html Cycles:180 Average:36986.39 Median:33185.92 stddev:56221.96 (169.4%) stddev-sans-first:56313.17 08:13:10 INFO - PROCESS | 28243 | Values: 565.8 589.6 612.7 622.1 627.3 27573.6 27773.0 28271.0 28316.7 28627.9 33071.3 33350.2 33915.7 34126.0 34175.8 7446.1 7659.5 7666.4 7666.7 7669.1 6996.7 7469.4 7621.0 7626.6 9308.3 9530.0 9690.2 9692.9 9694.5 9694.9 9517.1 9626.1 9636.7 9648.7 9649.3 9456.6 9562.5 9575.7 9582.6 9588.0 31309.8 35440.8 35537.1 35581.0 35643.8 3153.4 3166.0 3187.7 3188.7 3246.3 27318.2 27333.3 27506.4 28220.7 28439.4 3407.8 3414.6 3473.2 3547.5 3560.5 200446.0 200813.0 201016.0 201666.9 202274.0 48410.0 48509.8 48548.5 48560.3 48645.8 46489.0 47040.5 47055.5 47117.3 47121.3 13588.8 13769.4 13780.4 13784.9 13786.0 10182.8 10214.9 10218.1 10225.4 10227.2 14964.0 15776.8 15824.4 15825.9 15881.6 5908.5 6096.5 6155.4 6197.4 6233.9 884.0 884.9 967.9 995.7 1053.6 25102.0 26069.6 26410.2 26483.0 26777.6 910.2 994.3 1024.0 1031.4 1077.1 13555.3 14104.6 14302.4 14356.4 14366.4 241919.0 245376.0 247576.0 248780.0 259700.0 43861.0 44063.6 44170.1 44205.0 44220.3 1152.4 1247.1 1258.8 1268.4 1280.6 23952.0 26530.2 27032.3 27123.7 27205.9 38261.0 38349.8 38375.4 38393.2 38542.6 194805.0 197159.0 197212.0 197699.0 197750.0 23148.4 24406.9 24429.8 24434.9 24443.0 37606.6 37687.8 37894.6 38384.4 38532.8 33106.8 33385.5 33543.5 33705.0 33794.3 32495.5 32903.3 33131.7 33258.8 33306.3 33083.5 33240.2 33330.5 33341.8 33603.0 28760.3 29840.6 29972.1 30003.5 30086.8 22841.7 23433.0 23558.2 23748.3 23759.3 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#2] jquery.html Cycles:180 Average:22023.22 Median:4967.04 stddev:59366.04 (1195.2%) stddev-sans-first:59510.34 08:13:10 INFO - PROCESS | 28243 | Values: 379.3 391.9 392.5 396.2 403.6 15157.7 15344.5 15693.7 15712.8 15723.8 15392.5 15907.9 16159.0 16247.8 16266.9 4818.4 4994.4 5015.8 5021.1 5022.3 4984.6 5021.7 5031.9 5050.6 5071.5 4949.5 5022.6 5022.8 5051.1 5093.7 5014.5 5034.6 5038.9 5102.4 5428.1 5270.9 5300.4 5319.9 5340.2 5344.1 11437.6 12001.7 12035.3 12051.0 18824.8 1916.3 1973.5 2131.2 2234.3 2236.3 8979.4 9224.5 9382.1 10656.3 12287.7 1652.4 1674.5 1713.9 1734.1 1772.8 57762.0 60909.7 61255.4 61482.4 61570.4 9913.4 10005.2 10063.2 10091.8 10104.6 13761.4 13958.9 13981.3 13989.4 13997.8 7102.1 7155.9 7188.1 7281.8 7313.6 6729.0 6760.8 6762.6 6856.7 6897.8 4339.6 4378.6 4399.2 4428.7 4502.2 1847.0 1868.2 1876.6 1887.3 1911.9 886.4 890.3 900.1 903.8 938.6 15505.1 15749.0 15813.9 16419.1 16591.3 892.2 896.4 901.8 950.1 952.1 8886.7 9272.4 9357.9 9363.6 9518.7 355778.0 361059.0 362764.0 363586.0 364709.0 62052.7 63748.7 66465.0 66647.7 66793.7 939.6 942.5 948.5 955.7 963.5 14126.7 14261.8 14331.6 14358.4 14799.5 28538.6 30205.2 30891.0 31333.2 32082.8 35605.5 36101.8 36597.6 43012.0 43018.1 7362.3 7444.0 7632.8 7689.9 7744.8 9089.7 11229.7 11405.8 11412.7 11481.4 9395.2 9648.0 9694.3 9759.5 10007.7 9648.0 10090.4 10139.6 10147.7 10234.1 9308.2 9384.2 9585.5 9602.8 10034.0 7485.9 7486.1 7613.7 7638.7 7643.6 7632.5 8817.0 10035.3 10111.7 10145.6 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#3] mootools.html Cycles:180 Average:4943.72 Median:5650.84 stddev:2664.40 (47.2%) stddev-sans-first:2657.61 08:13:10 INFO - PROCESS | 28243 | Values: 1275.7 1443.1 1479.3 1598.7 1760.2 6582.2 7215.2 7345.4 7372.4 7376.6 7058.3 7232.6 7234.6 7244.1 7251.2 2209.7 2213.2 2224.2 2237.8 2238.9 2139.0 2195.2 2211.2 2212.4 2236.4 2224.9 2227.8 2233.0 2235.6 2265.4 2142.0 2178.2 2183.6 2183.8 2189.2 2139.3 2144.0 2149.0 2154.3 2155.1 7309.6 7371.9 7391.7 7395.3 7423.4 4463.7 4636.1 4645.0 4645.1 4650.2 2902.9 2930.3 2985.7 3013.4 3048.5 915.9 940.6 944.7 948.4 951.2 9891.9 9990.1 9995.6 9999.7 10015.2 4145.6 4188.3 4266.9 4281.6 4290.4 7969.6 8100.8 8103.5 8106.8 8123.6 4534.3 4604.8 4605.1 4609.2 4611.5 3789.5 4155.5 4244.6 4328.6 4347.4 3368.8 3386.2 3436.4 3452.6 3457.8 1082.8 1084.8 1087.5 1094.6 1094.7 838.4 839.6 851.7 870.6 871.5 5004.8 5011.9 5028.3 5211.8 5343.2 880.7 881.1 891.1 905.5 951.0 3243.3 3309.0 3391.2 3393.1 3402.8 8472.8 9039.0 9057.1 9075.1 9089.9 8818.4 8857.5 8902.9 8937.9 8938.6 6588.0 6857.4 6930.0 7097.5 7188.1 5236.8 5247.1 5249.7 5374.8 5390.9 8218.3 8438.9 8724.1 8790.4 8813.1 8769.3 8783.9 8944.0 8958.0 9014.9 5910.8 6337.2 6563.5 6572.8 6746.4 7065.4 7142.1 7158.2 7200.9 7203.3 6410.5 6658.5 6663.5 6751.6 6762.8 6487.6 6503.2 6513.5 6538.7 6611.9 6026.3 6087.6 6101.3 6102.8 6108.2 4299.5 4367.7 4387.8 4503.8 4510.1 4504.4 4509.8 4548.1 4665.3 4667.8 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#4] prototype.html Cycles:180 Average:4226.46 Median:4670.39 stddev:1235.35 (26.5%) stddev-sans-first:1203.22 08:13:10 INFO - PROCESS | 28243 | Values: 303.7 307.1 310.7 319.6 323.1 4667.7 4697.3 4707.6 4736.5 4738.2 4644.9 4652.5 4652.8 4654.6 4656.7 3591.3 3670.7 3711.6 3764.3 3797.6 3731.3 3752.3 3757.6 3765.4 3791.6 3540.7 3705.5 3720.7 3721.1 3736.0 3632.5 3743.9 3755.6 3756.3 3764.3 3339.2 3350.1 3366.3 3373.6 3380.6 4505.8 4511.3 4514.3 4524.1 4524.2 3971.2 4175.9 4195.8 4276.4 4283.6 4909.0 4924.1 4926.8 4938.4 4945.8 3537.4 3552.4 3556.8 3564.3 3581.7 5041.1 5082.9 5115.9 5151.8 5184.9 3583.7 3616.2 3619.3 3637.2 3637.7 3662.3 3669.0 3691.2 3691.2 3706.5 4134.2 4172.8 4176.9 4179.6 4193.8 4628.9 4919.5 4948.8 4967.3 4977.1 1331.2 1334.9 1338.4 1340.1 1341.0 849.0 893.9 903.9 913.5 914.8 4636.1 4656.4 4656.9 4663.4 4683.8 5372.9 5384.6 5406.3 5423.2 5439.6 4522.3 4617.8 4632.5 4651.3 4673.0 2821.9 2841.8 2865.1 2871.9 2877.4 5092.9 5096.8 5100.9 5119.8 5129.0 5310.8 5432.2 5453.9 5469.0 5504.7 5109.5 5114.3 5142.3 5148.7 5150.7 5355.3 5377.0 5400.1 5401.2 5429.2 5105.6 5263.1 5282.4 5286.6 5287.4 5041.0 5117.8 5149.3 5159.6 5171.7 3834.7 3837.8 3841.9 3846.7 3848.4 5286.6 5383.5 5385.8 5392.1 5410.9 5134.3 5188.2 5188.9 5203.1 5220.3 5010.7 5188.3 5190.1 5203.2 5211.0 4638.7 5111.2 5135.6 5136.3 5144.8 4773.9 4871.8 4893.1 4915.7 4926.2 4845.0 4868.5 4896.2 4915.0 4920.6 08:13:10 INFO - PROCESS | 28243 | 08:13:10 INFO - PROCESS | 28243 | [#5] yui.html Cycles:180 Average:12307.78 Median:43410.28 stddev:13533.71 (31.2%) stddev-sans-first:13543.47 08:13:10 INFO - PROCESS | 28243 | Values: 672.0 680.9 697.2 724.6 741.7 11335.5 11894.2 13739.4 14155.8 14191.1 13442.4 13507.6 13522.4 13526.1 13585.5 639.5 791.2 804.5 810.8 814.1 817.1 822.4 823.1 823.7 824.4 850.4 860.4 860.8 861.0 861.5 666.7 825.1 848.8 849.7 852.4 616.5 617.5 617.6 618.6 618.9 12522.6 12579.9 12589.4 12591.7 12603.7 11402.6 11684.5 11898.2 11956.6 12569.7 9461.3 9544.2 9683.0 9707.3 9786.7 3269.3 3327.5 3396.9 3453.2 3474.7 43162.4 43171.4 43228.8 43572.0 43981.8 9662.3 9662.7 9700.4 9749.8 9789.9 16526.9 16642.7 16661.9 16720.3 16724.4 6633.1 6679.4 6717.0 6743.1 6795.9 3739.4 3786.3 3806.7 3904.6 3912.3 2852.3 2924.2 2931.4 2931.8 2934.5 498.6 503.3 514.3 515.2 515.9 455.9 470.1 540.5 564.8 566.7 7549.7 7641.2 7647.0 7764.1 7864.7 572.4 583.6 593.3 615.0 640.5 3538.9 3645.6 3698.8 3734.6 3785.1 45838.3 47233.5 48830.5 50558.5 50904.5 41160.2 42537.6 42575.8 42901.0 43248.6 39825.4 40008.6 40327.8 40566.4 40978.0 7611.3 7662.5 7940.4 7964.5 8147.6 28473.9 28848.3 29161.0 29695.7 30563.2 35440.3 35804.5 35859.3 37091.4 40037.4 9248.9 10246.4 10303.5 10434.5 10595.8 10051.7 10294.3 10431.7 11874.6 12593.7 8265.6 10093.5 11010.2 11144.0 11592.0 11220.7 11243.3 11280.3 11489.7 11719.1 9842.9 9998.4 10150.1 10202.9 10259.0 9302.9 9734.5 9755.5 10281.9 10315.6 9194.8 9607.6 9688.5 9771.1 9779.4 08:13:10 INFO - PROCESS | 28243 | -------- Summary: end -------- 08:13:10 INFO - PROCESS | 28243 | 08:13:11 INFO - TEST-INFO | 28243: exit 0 08:13:11 INFO - TEST-OK | dromaeo_css | took 1117503ms 08:13:11 INFO - TEST-START | kraken 08:13:11 INFO - operating with platform_type : linux_ 08:13:11 INFO - Initialising browser for kraken test... 08:13:11 INFO - TEST-INFO | started process 28416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsYntQh/profile http://localhost:39862/getInfo.html) 08:13:15 INFO - PROCESS | 28416 | __metrics Screen width/height:1600/1200 08:13:15 INFO - PROCESS | 28416 | colorDepth:24 08:13:15 INFO - PROCESS | 28416 | Browser inner width/height: 1024/697 08:13:15 INFO - PROCESS | 28416 | __metrics 08:13:16 ERROR - PROCESS | 28416 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:13:16 INFO - TEST-INFO | 28416: exit 0 08:13:16 INFO - Browser initialized. 08:13:16 INFO - Running cycle 1/1 for kraken test... 08:13:16 INFO - TEST-INFO | started process 28497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsYntQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:28 INFO - PROCESS | 28497 | RSS: Main: 155742208 08:13:28 INFO - PROCESS | 28497 | 08:13:31 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39862/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:32 INFO - PROCESS | 28497 | RSS: Main: 210673664 08:13:32 INFO - PROCESS | 28497 | 08:13:35 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39862/tests/kraken/driver.html?testName=audio-dft) 08:13:35 INFO - PROCESS | 28497 | RSS: Main: 196059136 08:13:35 INFO - PROCESS | 28497 | 08:13:39 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39862/tests/kraken/driver.html?testName=audio-fft) 08:13:39 INFO - PROCESS | 28497 | RSS: Main: 267796480 08:13:39 INFO - PROCESS | 28497 | 08:13:41 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39862/tests/kraken/driver.html?testName=audio-oscillator) 08:13:42 INFO - PROCESS | 28497 | RSS: Main: 175013888 08:13:42 INFO - PROCESS | 28497 | 08:13:44 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:45 INFO - PROCESS | 28497 | RSS: Main: 179605504 08:13:45 INFO - PROCESS | 28497 | 08:13:48 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39862/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:49 INFO - PROCESS | 28497 | RSS: Main: 215207936 08:13:49 INFO - PROCESS | 28497 | 08:13:52 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39862/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:53 INFO - PROCESS | 28497 | RSS: Main: 213086208 08:13:53 INFO - PROCESS | 28497 | 08:13:55 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39862/tests/kraken/driver.html?testName=json-parse-financial) 08:13:56 INFO - PROCESS | 28497 | RSS: Main: 215109632 08:13:56 INFO - PROCESS | 28497 | 08:13:58 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:58 INFO - PROCESS | 28497 | RSS: Main: 202883072 08:13:58 INFO - PROCESS | 28497 | 08:14:00 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:01 INFO - PROCESS | 28497 | RSS: Main: 203841536 08:14:01 INFO - PROCESS | 28497 | 08:14:03 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:04 INFO - PROCESS | 28497 | RSS: Main: 218095616 08:14:04 INFO - PROCESS | 28497 | 08:14:06 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:07 INFO - PROCESS | 28497 | RSS: Main: 224346112 08:14:07 INFO - PROCESS | 28497 | 08:14:11 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:11 INFO - PROCESS | 28497 | RSS: Main: 218918912 08:14:11 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | Cycle 1(1): loaded http://localhost:39862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39862/tests/kraken/driver.html?testName=ai-astar) 08:14:13 INFO - PROCESS | 28497 | RSS: Main: 282177536 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | __start_tp_report 08:14:13 INFO - PROCESS | 28497 | _x_x_mozilla_page_load 08:14:13 INFO - PROCESS | 28497 | _x_x_mozilla_page_load_details 08:14:13 INFO - PROCESS | 28497 | |i|pagename|runs| 08:14:13 INFO - PROCESS | 28497 | |0;ai-astar;111;112;106;112;113;111;103;112;113;112 08:14:13 INFO - PROCESS | 28497 | |1;audio-beat-detection;175;135;162;181;136;157;160;132;184;137 08:14:13 INFO - PROCESS | 28497 | |2;audio-dft;161;161;159;162;162;162;163;160;161;163 08:14:13 INFO - PROCESS | 28497 | |3;audio-fft;77;78;114;122;77;74;74;115;115;77 08:14:13 INFO - PROCESS | 28497 | |4;audio-oscillator;93;95;154;93;94;93;140;93;93;149 08:14:13 INFO - PROCESS | 28497 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;116;116;117 08:14:13 INFO - PROCESS | 28497 | |6;imaging-darkroom;147;146;147;146;148;146;146;147;147;146 08:14:13 INFO - PROCESS | 28497 | |7;imaging-desaturate;94;95;94;95;95;94;94;94;94;95 08:14:13 INFO - PROCESS | 28497 | |8;json-parse-financial;62;65;64;77;63;64;72;82;64;60 08:14:13 INFO - PROCESS | 28497 | |9;json-stringify-tinderbox;64;65;64;64;64;65;64;64;65;65 08:14:13 INFO - PROCESS | 28497 | |10;stanford-crypto-aes;79;79;79;78;80;80;79;81;87;81 08:14:13 INFO - PROCESS | 28497 | |11;stanford-crypto-ccm;135;143;132;130;134;131;136;137;175;136 08:14:13 INFO - PROCESS | 28497 | |12;stanford-crypto-pbkdf2;213;216;220;223;228;212;216;218;216;211 08:14:13 INFO - PROCESS | 28497 | |13;stanford-crypto-sha256-iterative;77;77;76;74;75;75;73;76;75;74 08:14:13 INFO - PROCESS | 28497 | __end_tp_report 08:14:13 INFO - PROCESS | 28497 | __start_cc_report 08:14:13 INFO - PROCESS | 28497 | _x_x_mozilla_cycle_collect,1918 08:14:13 INFO - PROCESS | 28497 | __end_cc_report 08:14:13 INFO - PROCESS | 28497 | __startTimestamp1461770053721__endTimestamp 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | ------- Summary: start ------- 08:14:13 INFO - PROCESS | 28497 | Number of tests: 14 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 08:14:13 INFO - PROCESS | 28497 | Values: 111.0 112.0 106.0 112.0 113.0 111.0 103.0 112.0 113.0 112.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:161.00 stddev:20.00 (12.4%) stddev-sans-first:19.99 08:14:13 INFO - PROCESS | 28497 | Values: 175.0 135.0 162.0 181.0 136.0 157.0 160.0 132.0 184.0 137.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 08:14:13 INFO - PROCESS | 28497 | Values: 161.0 161.0 159.0 162.0 162.0 162.0 163.0 160.0 161.0 163.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:20.98 (27.8%) stddev-sans-first:21.51 08:14:13 INFO - PROCESS | 28497 | Values: 77.0 78.0 114.0 122.0 77.0 74.0 74.0 115.0 115.0 77.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:26.42 (28.4%) stddev-sans-first:27.32 08:14:13 INFO - PROCESS | 28497 | Values: 93.0 95.0 154.0 93.0 94.0 93.0 140.0 93.0 93.0 149.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:14:13 INFO - PROCESS | 28497 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:14:13 INFO - PROCESS | 28497 | Values: 147.0 146.0 147.0 146.0 148.0 146.0 146.0 147.0 147.0 146.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:14:13 INFO - PROCESS | 28497 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:64.50 stddev:7.23 (11.2%) stddev-sans-first:7.41 08:14:13 INFO - PROCESS | 28497 | Values: 62.0 65.0 64.0 77.0 63.0 64.0 72.0 82.0 64.0 60.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:14:13 INFO - PROCESS | 28497 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:2.54 (3.2%) stddev-sans-first:2.65 08:14:13 INFO - PROCESS | 28497 | Values: 79.0 79.0 79.0 78.0 80.0 80.0 79.0 81.0 87.0 81.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:136.00 stddev:13.20 (9.7%) stddev-sans-first:13.93 08:14:13 INFO - PROCESS | 28497 | Values: 135.0 143.0 132.0 130.0 134.0 131.0 136.0 137.0 175.0 136.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.30 Median:217.00 stddev:5.23 (2.4%) stddev-sans-first:5.31 08:14:13 INFO - PROCESS | 28497 | Values: 213.0 216.0 220.0 223.0 228.0 212.0 216.0 218.0 216.0 211.0 08:14:13 INFO - PROCESS | 28497 | 08:14:13 INFO - PROCESS | 28497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.50 stddev:1.32 (1.7%) stddev-sans-first:1.22 08:14:13 INFO - PROCESS | 28497 | Values: 77.0 77.0 76.0 74.0 75.0 75.0 73.0 76.0 75.0 74.0 08:14:13 INFO - PROCESS | 28497 | -------- Summary: end -------- 08:14:13 INFO - PROCESS | 28497 | 08:14:14 INFO - TEST-INFO | 28497: exit 0 08:14:14 INFO - TEST-OK | kraken | took 63576ms 08:14:14 INFO - SUITE-END | took 1181s 08:14:14 INFO - Completed test suite (00:19:41) 08:14:14 INFO - javascript benchmark 08:14:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.50305441966, 2686.0, 2686.4761371532536, 2695.7034726180104, 2720.523908316044, 4608.815647374101, 4672.906541869161, 4675.532446755323, 4688.038952014837, 4711.2462006078995, 4651.279051746977, 4663.417072865892, 4664.8134074637055, 4756.453007904092, 4758.048390321941, 4287.8070486828165, 4290.0, 4334.696571240014, 4362.5637436256275, 4443.511213766483, 4361.236783562879, 4388.1223755249075, 4398.934015989763, 4439.089986552765, 4459.888502787424, 4188.68584856137, 4259.787010649455, 4315.050688848449, 4318.611324980767, 4387.210302145612, 4274.957250427518, 4324.156789426063, 4334.696571240014, 4337.392765012901, 4372.431583894106, 4273.636740876998, 4298.290782020994, 4313.590208930146, 4322.243607368698, 4346.304591265414, 4506.819727210907, 4538.228501154778, 4585.243434833248, 4616.5152658970665, 4630.166570017395, 4957.628177886673, 4975.029869175512, 4975.552200301954, 4979.053979743873, 5013.623978201613, 4964.404271487409, 5001.224810154432, 5003.299538064637, 5003.324551185616, 5053.418856831438, 4626.930596041028, 4664.930026049612, 4703.247480403119, 4776.283557466408, 4779.0680817241, 5070.062038522885, 5072.087024335581, 5075.695458272442, 5086.669366491166, 5100.948990510122, 4851.2723091535845, 4865.0999565079865, 4866.635002374836, 4873.31773551703, 4926.729029903389, 4884.633652476078, 5048.268001139814, 5072.416672082758, 5108.642395032312, 5115.616328775357, 4916.631252656065, 4943.555080042814, 4945.406551213878, 4950.2822090796635, 5000.099982003274, 4827.975860120677, 4916.385451818523, 4924.384451943507, 4927.531884470969, 4968.975155124202, 4156.625903668684, 4160.043190066242, 4232.174725928476, 4239.788010599457, 4241.448611680462, 3638.472421498868, 3664.3953747631876, 3664.5052917855746, 3696.6857817085847, 3704.9629503705155, 4325.394444777734, 4328.913421731548, 4334.523202447728, 4336.306191009423, 4376.518582955872, 4886.267059940967, 5006.249062640561, 5037.042961837239, 5052.141136006888, 5081.949180508222, 4313.180495705806, 4316.115196384733, 4342.891427714332, 4348.065165989327, 4389.473263208435, 4484.641228701696, 4492.034212644297, 4495.662825288116, 4498.887527811831, 4553.977230113828, 4644.535546445329, 4690.6012988895645, 4736.692115012514, 4755.881102972453, 4770.713757174581, 4972.229304457815, 4992.700437973734, 4998.2002879539095, 5004.474530174425, 5056.721880296619, 4712.764361781966, 4754.928676069931, 4761.809527618856, 4767.308740232577, 4820.180569303297, 4769.952300476951, 4968.552830245295, 4988.42633097184, 5023.874403139951, 5042.042012017705, 4977.850664480072, 5002.749862506787, 5006.774695138801, 5011.123053465702, 5058.3929928408825, 4756.7145971241835, 4877.12211801879, 4878.536539028786, 4878.829240976549, 4925.950740492693, 4795.976020119877, 4825.252085926687, 4853.247746599282, 4870.464248932543, 4905.337779399735, 4816.831410900601, 4826.782794774173, 4836.419629644465, 4840.903181936412, 4881.658283920092, 4787.3776409066595, 4873.805047798191, 4919.139150648551, 4941.876453088702, 4997.950020499894, 4761.833335833229, 4784.760761961818, 4788.377510923558, 4808.735519546459, 4837.661363704507], "value": 4597.261080589507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8245943757436, 589.5902347868231, 612.727336335331, 622.0886401421917, 627.3068259573174, 27573.58639620407, 27773.0, 28271.0, 28316.716832831666, 28627.856860715692, 33071.33857322858, 33350.16624584381, 33915.66084339156, 34126.0, 34175.82912085436, 7446.143693475252, 7659.540427574336, 7666.3866890648615, 7666.7316643917475, 7669.079710434756, 6996.685149168275, 7469.365103966169, 7621.047369078865, 7626.618669066552, 9308.255339572852, 9530.0, 9690.224782017456, 9692.854607180898, 9694.466804325759, 9694.854577181313, 9517.143457088861, 9626.133647971681, 9636.662716804949, 9648.662296819577, 9649.276304277137, 9456.574454149511, 9562.521873906346, 9575.664851730226, 9582.616695332248, 9588.0, 31309.843450782828, 35440.822795885855, 35537.1115722109, 35581.0, 35643.82178089119, 3153.369326134782, 3166.0343595203453, 3187.6971687689634, 3188.7289580385695, 3246.2533617267923, 27318.180454586392, 27333.316667083283, 27506.449871002667, 28220.717792822015, 28439.431211375864, 3407.8296085195643, 3414.590249170091, 3473.166440054394, 3547.5033495310677, 3560.4659301104784, 200446.0, 200813.0, 201016.0, 201666.9249883759, 202273.99999999852, 48410.0, 48509.75745121252, 48548.51451485511, 48560.27159592609, 48645.75677121663, 46489.0, 47040.5295947043, 47055.5294447058, 47117.293240601415, 47121.29318060232, 13588.796168057486, 13769.449222031208, 13780.379882905294, 13784.931075344559, 13786.0, 10182.796344073226, 10214.948925255327, 10218.080372766486, 10225.43760093202, 10227.181825453947, 14964.0, 15776.842231577766, 15824.446144385121, 15825.920870395574, 15881.602959926095, 5908.497777688859, 6096.481799047042, 6155.384461553898, 6197.411245931629, 6233.906491402633, 883.969061082859, 884.8761173435724, 967.908048735369, 995.6963126246565, 1053.562771449855, 25102.0, 26069.60895586568, 26410.207693769218, 26483.0, 26777.598336024974, 910.2035718746097, 994.2841154368842, 1024.0374048394485, 1031.4017869635593, 1077.1490522487147, 13555.254461004739, 14104.576862694135, 14302.356393962296, 14356.425742970374, 14366.35351409189, 241919.0, 245376.0, 247576.0, 248780.0, 259700.0, 43861.0, 44063.55936440659, 44170.11659766787, 44205.0, 44220.336694949605, 1152.383474840956, 1247.1207798502217, 1258.7545428641326, 1268.4482250221183, 1280.5582074184392, 23952.0, 26530.204093877215, 27032.324191894575, 27123.728762712908, 27205.86397068002, 38261.0, 38349.808250958566, 38375.42436863393, 38393.23213535658, 38542.614573853905, 194805.0, 197159.0, 197212.0, 197699.0, 197750.0, 23148.421289467897, 24406.87796561006, 24429.755702443457, 24434.877825610758, 24443.0, 37606.62393376031, 37687.81156094202, 37894.62105378911, 38384.42423363707, 38532.80733596314, 33106.83446582848, 33385.499217512246, 33543.49684754682, 33705.0, 33794.3241135171, 32495.512567311038, 32903.34193316168, 33131.66868331382, 33258.83370583132, 33306.335493160004, 33083.50374744429, 33240.16899577433, 33330.500042499865, 33341.83329083339, 33603.0, 28760.280992975342, 29840.552391713707, 29972.100836974925, 30003.54994675038, 30086.849565752906, 22841.657375139053, 23433.0, 23558.175463858683, 23748.287551373487, 23759.287221383387], "value": 16322.935565654148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3229086081345, 391.8623906589554, 392.5426877687496, 396.1897918756144, 403.5903557888743, 15157.696846063072, 15344.539663810103, 15693.686126277467, 15712.842871571294, 15723.764143537841, 15392.538223853275, 15907.92046039771, 16159.0, 16247.83752162478, 16266.861319707625, 4818.445878723948, 4994.375703037121, 5015.774290156934, 5021.096202683534, 5022.271770593262, 4984.626153038536, 5021.723805190732, 5031.874203144914, 5050.595952323805, 5071.492850714917, 4949.455559888409, 5022.648414610979, 5022.799088036474, 5051.1413059779925, 5093.650182701587, 5014.52362025607, 5034.597232221432, 5038.949610503884, 5102.438731739506, 5428.104362780136, 5270.92093618596, 5300.443453437372, 5319.920201196946, 5340.172273297645, 5344.0915044442145, 11437.59968401102, 12001.699957501045, 12035.27788332694, 12051.0, 18824.81175188258, 1916.252661462031, 1973.4572992427054, 2131.2007997001124, 2234.2515257388795, 2236.317923033474, 8979.416337938013, 9224.53877306132, 9382.10869967352, 10656.254062215648, 12287.69280767988, 1652.4464304458022, 1674.5060207238894, 1713.9314427422887, 1734.1156010434643, 1772.7784026996626, 57762.0, 60909.6954515229, 61255.387446125416, 61482.38517614811, 61570.38429615691, 9913.355631883904, 10005.249606279558, 10063.245256605784, 10091.798164036825, 10104.595816167272, 13761.449542018407, 13958.930205348908, 13981.300934953211, 13989.3704783285, 13997.790033149511, 7102.112235970504, 7155.89266161008, 7188.137423509108, 7281.817954551073, 7313.561186328731, 6728.981305608298, 6760.763373281911, 6762.628055456997, 6856.657167141623, 6897.827554311082, 4339.63113135387, 4378.64970802335, 4399.1641588098155, 4428.6678499112695, 4502.212112880298, 1846.9722954155698, 1868.1593283022694, 1876.6434377468238, 1887.292265400475, 1911.858718235585, 886.4459712679575, 890.3189060368823, 900.0774206438452, 903.75146834621, 938.648006997376, 15505.147216903179, 15749.0, 15813.920930395274, 16419.096949667644, 16591.25339359732, 892.205936716323, 896.4486840592988, 901.756525738047, 950.0689324462066, 952.0764858087643, 8886.73339799807, 9272.443653380818, 9357.859632105525, 9363.578638961262, 9518.666846660333, 355778.0, 361059.0, 362764.0, 363586.0, 364709.0, 62052.68973655103, 63748.68125659435, 66465.0, 66647.66676166588, 66793.66603167051, 939.6053657463882, 942.5193151492651, 948.4830767231875, 955.6798472511787, 963.5278713430368, 14126.717465650834, 14261.786073209118, 14331.570052898429, 14358.353874075483, 14799.482018129314, 28538.57192142078, 30205.244868878453, 30891.0, 31333.216669583442, 32082.839585802856, 35605.46591801177, 36101.81949090238, 36597.63402366049, 43012.0, 43018.13963720771, 7362.300581444754, 7444.0, 7632.809179770328, 7689.923100769144, 7744.7676569703, 9089.681861135094, 11229.71925701864, 11405.830265645143, 11412.657620271406, 11481.425928703698, 9395.201407880133, 9648.035196480296, 9694.272929530172, 9759.463229522444, 10007.749806254902, 9648.0, 10090.39457632515, 10139.594416223563, 10147.695569132939, 10234.130098941674, 9308.162265396148, 9384.155426011692, 9585.520723963913, 9602.807943840944, 10034.046765557261, 7485.887711684438, 7486.139094004259, 7613.695452181851, 7638.732644357421, 7643.57960312166, 7632.465727399029, 8817.0, 10035.316652699768, 10111.7472063199, 10145.594176232868], "value": 7821.302338031588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.7257189704212, 1443.1269082205263, 1479.312119864263, 1598.7362085255927, 1760.2255007796578, 6582.243042050166, 7215.2063273039985, 7345.375643070332, 7372.447066470009, 7376.557406555604, 7058.329458701415, 7232.566046037228, 7234.565926044441, 7244.130704315489, 7251.238619944896, 2209.668549717543, 2213.2474958514103, 2224.232639739287, 2237.7538470768204, 2238.932832015034, 2138.967915481269, 2195.220696652689, 2211.159759291475, 2212.413710366754, 2236.3738153317017, 2224.9332520024427, 2227.766084561122, 2233.0, 2235.5864165129424, 2265.4449659833363, 2142.046789178816, 2178.2485042660337, 2183.5960347335795, 2183.759786423492, 2189.200941656292, 2139.326112274644, 2143.967840482394, 2148.957020859574, 2154.310620601408, 2155.094860158737, 7309.634518274065, 7371.88942165868, 7391.741289054911, 7395.260473952616, 7423.4061275097865, 4463.68754187207, 4636.11913736389, 4645.0, 4645.094206629708, 4650.162970665279, 2902.912912612625, 2930.2674331417147, 2985.6566494853155, 3013.3973205358798, 3048.496997995328, 915.8626206069076, 940.586142097475, 944.6788092048668, 948.3598570964572, 951.1867353412802, 9891.851622225673, 9990.05094516027, 9995.550200241007, 9999.700008999742, 10015.248856335731, 4145.626893579532, 4188.308929026676, 4266.893327666833, 4281.614654681093, 4290.356446532983, 7969.601519923981, 8100.756977290691, 8103.473274237156, 8106.837863242702, 8123.593820309079, 4534.274516077412, 4604.769761511911, 4605.078984203173, 4609.1703493371515, 4611.469680986663, 3789.4694742736037, 4155.459790227251, 4244.639205667491, 4328.61042506176, 4347.413099231563, 3368.79787212768, 3386.204242003127, 3436.398630239748, 3452.6202117767025, 3457.8098204598987, 1082.7780305037447, 1084.815581351172, 1087.4617064553097, 1094.6223552874246, 1094.655183617158, 838.3879767769563, 839.5550358310105, 851.7487341234227, 870.629982257538, 871.5467956662627, 5004.799808007711, 5011.899762004739, 5028.346314979102, 5211.765470553834, 5343.225232341289, 880.6873559886276, 881.1188811188811, 891.148952750122, 905.538175530471, 950.9714708558754, 3243.2540515681526, 3308.9503657445157, 3391.236971681352, 3393.100828280508, 3402.8128452935325, 8472.830543389098, 9039.0, 9057.09429057089, 9075.13786190311, 9089.909100908906, 8818.426802257833, 8857.468551886908, 8902.910970890338, 8937.865932011026, 8938.553072346356, 6587.9670601646685, 6857.417119544894, 6930.0, 7097.538659987084, 7188.101487314086, 5236.816711415082, 5247.08176069194, 5249.7375131242525, 5374.758135883816, 5390.919136212881, 8218.301444377295, 8438.915610843813, 8724.127587241224, 8790.42862213954, 8813.118688131392, 8769.342299327449, 8783.91216087831, 8943.955280223558, 8957.955210223907, 9014.864777028219, 5910.763569457174, 6337.207849018872, 6563.474922006132, 6572.76995305162, 6746.392824645805, 7065.434765218873, 7142.142942846684, 7158.212596614472, 7200.855982880418, 7203.315685009916, 6410.5192110592825, 6658.467322614082, 6663.466922646274, 6751.56114852533, 6762.830929226809, 6487.578307410004, 6503.219613646393, 6513.478921686348, 6538.705758240795, 6611.933880661324, 6026.337102918587, 6087.634741915499, 6101.267847858286, 6102.786402475892, 6108.17539632144, 4299.505556860876, 4367.694261401672, 4387.758673273001, 4503.842365517191, 4510.097980403998, 4504.414426124583, 4509.842155524541, 4548.067646132468, 4665.346851440733, 4667.789949452351], "value": 4039.691621632955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7175426853026, 307.14613374817986, 310.6924145096354, 319.5606041692672, 323.10822130918666, 4667.743274119922, 4697.2719228519545, 4707.646926480515, 4736.455307639618, 4738.15212067294, 4644.860654180372, 4652.534746525345, 4652.837150699726, 4654.557817007388, 4656.720596764197, 3591.2637909228547, 3670.6696397324235, 3711.647393497627, 3764.2659681362147, 3797.563280222782, 3731.347014272505, 3752.3058234226755, 3757.5678796938428, 3765.4351847222997, 3791.563970143441, 3540.716742660594, 3705.5182826232685, 3720.683741881943, 3721.1441368485266, 3735.9813200934095, 3632.527771389716, 3743.850245990157, 3755.586885442599, 3756.2675278320876, 3764.3224219640456, 3339.248669049469, 3350.095474221971, 3366.309906469168, 3373.612034616026, 3380.594328680574, 4505.842295519674, 4511.345854851028, 4514.277715565527, 4524.09518096382, 4524.185646583614, 3971.245463361952, 4175.874723758292, 4195.769232692201, 4276.401303817468, 4283.593058659422, 4908.9754551227015, 4924.113659541281, 4926.778294976699, 4938.358013458227, 4945.7774400152075, 3537.4340105582983, 3552.3605750964816, 3556.751027428081, 3564.2515071834946, 3581.6776490116013, 5041.143525203222, 5082.872928176788, 5115.897682046376, 5151.845444636667, 5184.948150518522, 3583.6595523425235, 3616.2405894762396, 3619.3123306571665, 3637.1630128499814, 3637.727170462226, 3662.340778659867, 3668.99142702981, 3691.187938653492, 3691.2063906259746, 3706.4810926470313, 4134.214499245134, 4172.812223449952, 4176.895577610523, 4179.6238338549065, 4193.769342686121, 4628.884277893012, 4919.4834542373255, 4948.802047918115, 4967.254911763264, 4977.129002424561, 1331.2212355771787, 1334.9132306400054, 1338.4044100375434, 1340.1155237543176, 1341.0, 848.966041358351, 893.8659201119884, 903.8779764731677, 913.488446469979, 914.8078903430221, 4636.095961287584, 4656.4412270527755, 4656.906861862743, 4663.393758811333, 4683.789229484613, 5372.892542149135, 5384.6499977501335, 5406.2701535292235, 5423.186522021729, 5439.619226654176, 4522.25382811839, 4617.79219935097, 4632.467266264355, 4651.2557990721325, 4673.042026384583, 2821.8730157142977, 2841.758450531687, 2865.0545320044334, 2871.9425611488073, 2877.3525956659582, 5092.9236061459105, 5096.770645320969, 5100.923486147711, 5119.769610367543, 5129.0, 5310.769476819745, 5432.158015507603, 5453.918191227135, 5469.0, 5504.724763761796, 5109.489051094935, 5114.312276948598, 5142.331496905378, 5148.742562871841, 5150.690958542425, 5355.259540649226, 5377.0, 5400.135978243462, 5401.2168235606405, 5429.185622156708, 5105.617078719037, 5263.105272103675, 5282.418933917343, 5286.62993590445, 5287.391949925808, 5041.0, 5117.8464646060675, 5149.253358262956, 5159.561437277874, 5171.715555644476, 3834.654881060718, 3837.7505462144873, 3841.9231615366975, 3846.653801157909, 3848.4419759134207, 5286.62993590445, 5383.461653834742, 5385.75764090609, 5392.137258038695, 5410.862709229754, 5134.332536770196, 5188.195829646411, 5188.896222075613, 5203.115470370122, 5220.321358223407, 5010.749462526932, 5188.325517682677, 5190.143626301769, 5203.219517072469, 5211.0, 4638.6752927294765, 5111.156659151198, 5135.614828887923, 5136.2552429898205, 5144.768485418091, 4773.880652983703, 4871.805127794849, 4893.143699852582, 4915.729634870117, 4926.162552366178, 4844.975775121102, 4868.513148685103, 4896.216605343128, 4914.975425122851, 4920.630952678635], "value": 3842.376583790687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.979840604782, 680.8876535371664, 697.1912581405569, 724.6195747232703, 741.6921977379387, 11335.489902954367, 11894.226875253113, 13739.381727822247, 14155.787663185061, 14191.148531088142, 13442.39509222085, 13507.594772156826, 13522.391492382842, 13526.120802147878, 13585.456581736718, 639.4947991087035, 791.1850793682487, 804.485129517108, 810.8256724804166, 814.1004190369645, 817.1256755271861, 822.3955392786297, 823.0945959444623, 823.7034667519719, 824.3570015388007, 850.4259624753298, 860.3590325207729, 860.789106668867, 860.9913900861005, 861.4701958295666, 666.7433038280298, 825.0511911301991, 848.7793173774833, 849.7153453592992, 852.3990586636406, 616.5191150902303, 617.4566381584222, 617.5677026081761, 618.5700937848197, 618.9350118237566, 12522.561710340095, 12579.874201257962, 12589.370531473389, 12591.685207869876, 12603.684907877285, 11402.600908968147, 11684.532618695242, 11898.22661526998, 11956.641300760992, 12569.685757856036, 9461.290403219786, 9544.236461083166, 9683.0, 9707.320487565874, 9786.706398807975, 3269.29710112327, 3327.45097058985, 3396.9490457643155, 3453.1539772755837, 3474.704650104719, 43162.35256471155, 43171.352429713894, 43228.78385608052, 43572.0, 43981.78009109966, 9662.323637345458, 9662.71011869645, 9700.369475984038, 9749.756256093655, 9789.9021009789, 16526.917365413097, 16642.667146657, 16661.91669041647, 16720.331186752635, 16724.41464548759, 6633.137692100093, 6679.365460281266, 6716.966415167893, 6743.055972163901, 6795.932040679629, 3739.4390841373465, 3786.261678972629, 3806.676432503268, 3904.6095390460728, 3912.3349030664854, 2852.301186209392, 2924.225080353708, 2931.3697555025774, 2931.8240905545736, 2934.4864648686394, 498.61606562946326, 503.3129777853204, 514.2697369734985, 515.2194425445379, 515.8632962265003, 455.9270516717309, 470.1138354202353, 540.5486418840234, 564.7769131193156, 566.7364675425947, 7549.7357592483995, 7641.176177919321, 7647.0, 7764.145943946161, 7864.685412583547, 572.4161355417451, 583.6468936293567, 593.2791658135386, 615.0159744409, 640.5132099604334, 3538.8584456621447, 3645.6354364563863, 3698.7635818658673, 3734.607866174067, 3785.09157802131, 45838.31242531365, 47233.52766472291, 48830.51169488331, 50558.49441505538, 50904.49095509072, 41160.176796464504, 42537.57462425398, 42575.7871210642, 42901.0, 43248.567514325085, 39825.40261896074, 40008.599914000486, 40327.798361008005, 40566.39150412687, 40977.975550611474, 7611.2769286917655, 7662.463627546018, 7940.444168908121, 7964.482308649919, 8147.551884646165, 28473.857630711715, 28848.278793030342, 29160.979365722098, 29695.73346931879, 30563.2359191022, 35440.29119417546, 35804.4629330555, 35859.282814343045, 37091.44362834613, 40037.39943900786, 9248.861267080865, 10246.38521688701, 10303.484825758833, 10434.530446130095, 10595.841062383915, 10051.69844904654, 10294.279400442198, 10431.739206519898, 11874.584389546324, 12593.748125037264, 8265.586720664063, 10093.545790439595, 11010.174236932422, 11143.997040266415, 11592.0, 11220.66338009861, 11243.269187502787, 11280.2667826591, 11489.712757180803, 11719.121065919919, 9842.852357214791, 9998.400095994264, 10150.086492215441, 10202.897971020195, 10259.0, 9302.906970930475, 9734.513274336396, 9755.463449510346, 10281.897181028095, 10315.587376504856, 9194.770130746785, 9607.56765945548, 9688.467134307399, 9771.12059914611, 9779.364341317792], "value": 5826.381229853565, "unit": "score"}], "name": "dromaeo_css", "value": 6130.487711851076, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 112.0, 113.0, 111.0, 103.0, 112.0, 113.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 135.0, 162.0, 181.0, 136.0, 157.0, 160.0, 132.0, 184.0, 137.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 162.0, 162.0, 163.0, 160.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 114.0, 122.0, 77.0, 74.0, 74.0, 115.0, 115.0, 77.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 154.0, 93.0, 94.0, 93.0, 140.0, 93.0, 93.0, 149.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 77.0, 63.0, 64.0, 72.0, 82.0, 64.0, 60.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 80.0, 80.0, 79.0, 81.0, 87.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 132.0, 130.0, 134.0, 131.0, 136.0, 137.0, 175.0, 136.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 216.0, 220.0, 223.0, 228.0, 212.0, 216.0, 218.0, 216.0, 211.0], "value": 217.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 74.0, 75.0, 75.0, 73.0, 76.0, 75.0, 74.0], "value": 75.2, "unit": "score"}], "name": "kraken", "value": 1630.7, "alertThreshold": 2.0}]} 08:14:14 INFO - Return code: 0 08:14:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:14:15 ERROR - # TBPL SUCCESS # 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - Running post-run listener: _resource_record_post_run 08:14:16 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 16384; Write bytes: 524537856; Read time: 156; Write time: 445428 08:14:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246063104; Read time: 0; Write time: 265660 08:14:16 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 16384; Write bytes: 278474752; Read time: 156; Write time: 179768 08:14:16 INFO - Running post-run listener: _upload_blobber_files 08:14:16 INFO - Blob upload gear active. 08:14:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:16 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 08:14:16 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'] 08:14:16 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 08:14:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:17 INFO - (blobuploader) - INFO - Done attempting. 08:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:18 INFO - (blobuploader) - INFO - Done attempting. 08:14:18 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:18 INFO - Return code: 0 08:14:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64b62ea649be2f78c658331b2555689f5456a7fb8504ad4d9e28012a7ea6af77a93b806fa7c17040f8f529c690cfa1324d41902e3d59fe2d9b59057a66de0e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4563594655c95540dfeea25f6e92dcea0f4f6d586382fa41d942bdcec5a92c25bc1498d98df701c36535902037d12e8437f11e9a62413c62d21a54714b8e6ec4"} 08:14:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:18 INFO - Contents: 08:14:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64b62ea649be2f78c658331b2555689f5456a7fb8504ad4d9e28012a7ea6af77a93b806fa7c17040f8f529c690cfa1324d41902e3d59fe2d9b59057a66de0e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4563594655c95540dfeea25f6e92dcea0f4f6d586382fa41d942bdcec5a92c25bc1498d98df701c36535902037d12e8437f11e9a62413c62d21a54714b8e6ec4"} 08:14:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:18 INFO - Copying logs to upload dir... 08:14:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.141536 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-27 08:14:17.868656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 08:14:17.872694) ========= 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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64b62ea649be2f78c658331b2555689f5456a7fb8504ad4d9e28012a7ea6af77a93b806fa7c17040f8f529c690cfa1324d41902e3d59fe2d9b59057a66de0e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4563594655c95540dfeea25f6e92dcea0f4f6d586382fa41d942bdcec5a92c25bc1498d98df701c36535902037d12e8437f11e9a62413c62d21a54714b8e6ec4"} build_url:https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/NXly6XKLRpie2f1OpQUBBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64b62ea649be2f78c658331b2555689f5456a7fb8504ad4d9e28012a7ea6af77a93b806fa7c17040f8f529c690cfa1324d41902e3d59fe2d9b59057a66de0e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4563594655c95540dfeea25f6e92dcea0f4f6d586382fa41d942bdcec5a92c25bc1498d98df701c36535902037d12e8437f11e9a62413c62d21a54714b8e6ec4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 08:14:17.900854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:14:17.901171) ========= 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=82e07478c745e68b1fe4678a000001bc-1461768758.862849-1247891952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:14:17.983547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 08:14:17.983870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 08:14:17.984158) ========= ========= Total master_lag: 0.18 =========