builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1462936244.0 results: success (0) buildid: 20160510173021 builduid: b6a075f48b8b4a7e8410db36d3376e88 revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:43.997581) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:43.998047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:43.998331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.015594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.016004) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 20:10:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.8M=0s 2016-05-10 20:10:44 (35.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.146696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.147028) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.196533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.196898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --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 027b0144a1a6c2d62dfb1656e41597acfe6a22ef --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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 20:10:44,838 truncating revision to first 12 chars 2016-05-10 20:10:44,838 Setting DEBUG logging. 2016-05-10 20:10:44,838 attempt 1/10 2016-05-10 20:10:44,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027b0144a1a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 20:10:45,102 unpacking tar archive at: fx-team-027b0144a1a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.765526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.765842) ========= script_repo_revision: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.766223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.766487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 20:10:44.776149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-10 20:10:44.776417) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:45 INFO - MultiFileLogger online at 20160510 20:10:45 in /builds/slave/test 20:10:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:10:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:45 INFO - {'append_to_log': False, 20:10:45 INFO - 'base_work_dir': '/builds/slave/test', 20:10:45 INFO - 'blob_upload_branch': 'Fx-Team', 20:10:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:45 INFO - 'branch': 'Fx-Team', 20:10:45 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:45 INFO - 'config_files': ('talos/linux_config.py',), 20:10:45 INFO - 'default_actions': ('clobber', 20:10:45 INFO - 'read-buildbot-config', 20:10:45 INFO - 'download-and-extract', 20:10:45 INFO - 'populate-webroot', 20:10:45 INFO - 'create-virtualenv', 20:10:45 INFO - 'install', 20:10:45 INFO - 'run-tests'), 20:10:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:45 INFO - 'download_minidump_stackwalk': True, 20:10:45 INFO - 'download_symbols': 'ondemand', 20:10:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:45 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:45 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:45 INFO - 'installer_path': 'installer.exe', 20:10:45 INFO - 'log_level': 'info', 20:10:45 INFO - 'log_name': 'talos', 20:10:45 INFO - 'log_to_console': True, 20:10:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:45 INFO - 'opt_config_files': (), 20:10:45 INFO - 'pip_index': False, 20:10:45 INFO - 'sps_profile': False, 20:10:45 INFO - 'sps_profile_interval': 0, 20:10:45 INFO - 'suite': 'dromaeojs', 20:10:45 INFO - 'system_bits': '32', 20:10:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:45 INFO - 'title': 'talos-linux64-ix-012', 20:10:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:45 INFO - 'use_talos_json': True, 20:10:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:45 INFO - 'work_dir': 'build'} 20:10:45 INFO - ##### 20:10:45 INFO - ##### Running clobber step. 20:10:45 INFO - ##### 20:10:45 INFO - Running pre-action listener: _resource_record_pre_action 20:10:45 INFO - Running main action method: clobber 20:10:45 INFO - rmtree: /builds/slave/test/build 20:10:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:45 INFO - Running post-action listener: _resource_record_post_action 20:10:45 INFO - ##### 20:10:45 INFO - ##### Finished clobber step (success) 20:10:45 INFO - ##### 20:10:45 INFO - ##### 20:10:45 INFO - ##### Running read-buildbot-config step. 20:10:45 INFO - ##### 20:10:45 INFO - Running pre-action listener: _resource_record_pre_action 20:10:45 INFO - Running main action method: read_buildbot_config 20:10:45 INFO - Using buildbot properties: 20:10:45 INFO - { 20:10:45 INFO - "project": "", 20:10:45 INFO - "product": "firefox", 20:10:45 INFO - "script_repo_revision": "production", 20:10:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:10:45 INFO - "repository": "", 20:10:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:10:45 INFO - "buildid": "20160510173021", 20:10:45 INFO - "pgo_build": "True", 20:10:45 INFO - "basedir": "/builds/slave/test", 20:10:45 INFO - "buildnumber": 1140, 20:10:45 INFO - "slavename": "talos-linux64-ix-012", 20:10:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:10:45 INFO - "platform": "ubuntu64_hw", 20:10:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:10:45 INFO - "branch": "fx-team", 20:10:45 INFO - "repo_path": "integration/fx-team", 20:10:45 INFO - "revision": "027b0144a1a6c2d62dfb1656e41597acfe6a22ef", 20:10:45 INFO - "stage_platform": "linux64-pgo", 20:10:45 INFO - "builduid": "b6a075f48b8b4a7e8410db36d3376e88", 20:10:45 INFO - "slavebuilddir": "test" 20:10:45 INFO - } 20:10:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:10:45 INFO - Running post-action listener: _resource_record_post_action 20:10:45 INFO - ##### 20:10:45 INFO - ##### Finished read-buildbot-config step (success) 20:10:45 INFO - ##### 20:10:45 INFO - ##### 20:10:45 INFO - ##### Running download-and-extract step. 20:10:45 INFO - ##### 20:10:45 INFO - Running pre-action listener: _resource_record_pre_action 20:10:45 INFO - Running main action method: download_and_extract 20:10:45 INFO - mkdir: /builds/slave/test/build/tests 20:10:45 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')]} 20:10:45 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:48 INFO - Downloaded 1361 bytes. 20:10:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:48 INFO - Using the following test package requirements: 20:10:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:10:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:10:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'jsshell-linux-x86_64.zip'], 20:10:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:10:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:10:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:10:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:10:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:10:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:10:48 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')]} 20:10:48 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:54 INFO - Downloaded 23903496 bytes. 20:10:54 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'] 20:10:54 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 20:10:56 INFO - Return code: 0 20:10:56 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 20:10:56 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')]} 20:10:56 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:11:00 INFO - Downloaded 23903496 bytes. 20:11:00 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'] 20:11:00 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 20:11:01 INFO - Return code: 0 20:11:01 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')]} 20:11:01 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:11:02 INFO - Downloaded 10840152 bytes. 20:11:02 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'] 20:11:02 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 20:11:02 INFO - Return code: 0 20:11:02 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')]} 20:11:02 INFO - https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_38WHqwQeaGNcb3MY0cOA/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 20:11:07 INFO - Downloaded 58334754 bytes. 20:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:07 INFO - mkdir: /builds/slave/test/properties 20:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:07 INFO - Contents: 20:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:07 INFO - Running post-action listener: _resource_record_post_action 20:11:07 INFO - Running post-action listener: set_extra_try_arguments 20:11:07 INFO - ##### 20:11:07 INFO - ##### Finished download-and-extract step (success) 20:11:07 INFO - ##### 20:11:07 INFO - ##### 20:11:07 INFO - ##### Running populate-webroot step. 20:11:07 INFO - ##### 20:11:07 INFO - Running pre-action listener: _resource_record_pre_action 20:11:07 INFO - Running main action method: populate_webroot 20:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:07 INFO - '--tppagecycles', 20:11:07 INFO - '7'], 20:11:07 INFO - 'tests': ['tsvgm']}}, 20:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['damp', 'tps']}, 20:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['damp', 'tps']}, 20:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['dromaeo_dom']}, 20:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tsvgx', 20:11:07 INFO - 'tsvgr_opacity', 20:11:07 INFO - 'tart', 20:11:07 INFO - 'tscrollx', 20:11:07 INFO - 'cart']}, 20:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:07 INFO - 'tsvgr_opacity', 20:11:07 INFO - 'tart', 20:11:07 INFO - 'tscrollx', 20:11:07 INFO - 'cart']}, 20:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tp5o']}, 20:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['tp5o']}, 20:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s', 20:11:07 INFO - '--xperf_path', 20:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:07 INFO - 'tests': ['tp5n']}, 20:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--xperf_path', 20:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:07 INFO - 'tests': ['tp5n']}}, 20:11:07 INFO - 'talos.zip': {'path': '', 20:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:07 INFO - Running post-action listener: _resource_record_post_action 20:11:07 INFO - ##### 20:11:07 INFO - ##### Finished populate-webroot step (success) 20:11:07 INFO - ##### 20:11:07 INFO - ##### 20:11:07 INFO - ##### Running create-virtualenv step. 20:11:07 INFO - ##### 20:11:07 INFO - Running pre-action listener: _resource_record_pre_action 20:11:07 INFO - Running main action method: create_virtualenv 20:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:07 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 20:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:08 INFO - Using real prefix '/usr' 20:11:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:10 INFO - Installing pip.................done. 20:11:10 INFO - Return code: 0 20:11:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11: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', 'pip>=1.5'] in /builds/slave/test/build 20:11: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 pip>=1.5 20:11:10 INFO - Using env: {'DISPLAY': ':0', 20:11:10 INFO - 'HOME': '/home/cltbld', 20:11:10 INFO - 'LANG': 'en_US.UTF-8', 20:11:10 INFO - 'LANGUAGE': 'en_US:en', 20:11:10 INFO - 'LOGNAME': 'cltbld', 20:11:10 INFO - 'MAIL': '/var/mail/cltbld', 20:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:10 INFO - 'MOZ_NO_REMOTE': '1', 20:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:10 INFO - 'NO_EM_RESTART': '1', 20:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:10 INFO - 'PWD': '/builds/slave/test', 20:11:10 INFO - 'SHELL': '/bin/bash', 20:11:10 INFO - 'SHLVL': '1', 20:11:10 INFO - 'TERM': 'linux', 20:11:10 INFO - 'TMOUT': '86400', 20:11:10 INFO - 'USER': 'cltbld', 20:11:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:10 INFO - '_': '/tools/buildbot/bin/python'} 20:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:10 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 20:11:10 INFO - Cleaning up... 20:11:10 INFO - Return code: 0 20:11:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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', '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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11: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', 'psutil>=0.7.1'] in /builds/slave/test/build 20:11: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 psutil>=0.7.1 20:11:10 INFO - Using env: {'DISPLAY': ':0', 20:11:10 INFO - 'HOME': '/home/cltbld', 20:11:10 INFO - 'LANG': 'en_US.UTF-8', 20:11:10 INFO - 'LANGUAGE': 'en_US:en', 20:11:10 INFO - 'LOGNAME': 'cltbld', 20:11:10 INFO - 'MAIL': '/var/mail/cltbld', 20:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:10 INFO - 'MOZ_NO_REMOTE': '1', 20:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:10 INFO - 'NO_EM_RESTART': '1', 20:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:10 INFO - 'PWD': '/builds/slave/test', 20:11:10 INFO - 'SHELL': '/bin/bash', 20:11:10 INFO - 'SHLVL': '1', 20:11:10 INFO - 'TERM': 'linux', 20:11:10 INFO - 'TMOUT': '86400', 20:11:10 INFO - 'USER': 'cltbld', 20:11:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:10 INFO - '_': '/tools/buildbot/bin/python'} 20:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:10 INFO - Downloading/unpacking psutil>=0.7.1 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:12 INFO - Installing collected packages: psutil 20:11:12 INFO - Running setup.py install for psutil 20:11:13 INFO - building 'psutil._psutil_linux' extension 20:11:13 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 20:11:13 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 20:11:13 INFO - building 'psutil._psutil_posix' extension 20:11:13 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 20:11:13 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 20:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:13 INFO - Successfully installed psutil 20:11:13 INFO - Cleaning up... 20:11:13 INFO - Return code: 0 20:11:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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', '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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:11: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 mozsystemmonitor==0.0.0 20:11:13 INFO - Using env: {'DISPLAY': ':0', 20:11:13 INFO - 'HOME': '/home/cltbld', 20:11:13 INFO - 'LANG': 'en_US.UTF-8', 20:11:13 INFO - 'LANGUAGE': 'en_US:en', 20:11:13 INFO - 'LOGNAME': 'cltbld', 20:11:13 INFO - 'MAIL': '/var/mail/cltbld', 20:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:13 INFO - 'MOZ_NO_REMOTE': '1', 20:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:13 INFO - 'NO_EM_RESTART': '1', 20:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:13 INFO - 'PWD': '/builds/slave/test', 20:11:13 INFO - 'SHELL': '/bin/bash', 20:11:13 INFO - 'SHLVL': '1', 20:11:13 INFO - 'TERM': 'linux', 20:11:13 INFO - 'TMOUT': '86400', 20:11:13 INFO - 'USER': 'cltbld', 20:11:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:13 INFO - '_': '/tools/buildbot/bin/python'} 20:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:11:15 INFO - Installing collected packages: mozsystemmonitor 20:11:15 INFO - Running setup.py install for mozsystemmonitor 20:11:15 INFO - Successfully installed mozsystemmonitor 20:11:15 INFO - Cleaning up... 20:11:15 INFO - Return code: 0 20:11:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:15 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')]} 20:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:15 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')]} 20:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:15 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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:15 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 20:11:15 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 20:11:15 INFO - Using env: {'DISPLAY': ':0', 20:11:15 INFO - 'HOME': '/home/cltbld', 20:11:15 INFO - 'LANG': 'en_US.UTF-8', 20:11:15 INFO - 'LANGUAGE': 'en_US:en', 20:11:15 INFO - 'LOGNAME': 'cltbld', 20:11:15 INFO - 'MAIL': '/var/mail/cltbld', 20:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:15 INFO - 'MOZ_NO_REMOTE': '1', 20:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:15 INFO - 'NO_EM_RESTART': '1', 20:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:15 INFO - 'PWD': '/builds/slave/test', 20:11:15 INFO - 'SHELL': '/bin/bash', 20:11:15 INFO - 'SHLVL': '1', 20:11:15 INFO - 'TERM': 'linux', 20:11:15 INFO - 'TMOUT': '86400', 20:11:15 INFO - 'USER': 'cltbld', 20:11:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:15 INFO - '_': '/tools/buildbot/bin/python'} 20:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 INFO - Downloading docopt-0.6.1.tar.gz 20:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:18 INFO - Running setup.py install for blobuploader 20:11:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:18 INFO - Running setup.py install for requests 20:11:19 INFO - Running setup.py install for docopt 20:11:19 INFO - Successfully installed blobuploader requests docopt 20:11:19 INFO - Cleaning up... 20:11:19 INFO - Return code: 0 20:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:19 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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:19 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 20:11:19 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 20:11:19 INFO - Using env: {'DISPLAY': ':0', 20:11:19 INFO - 'HOME': '/home/cltbld', 20:11:19 INFO - 'LANG': 'en_US.UTF-8', 20:11:19 INFO - 'LANGUAGE': 'en_US:en', 20:11:19 INFO - 'LOGNAME': 'cltbld', 20:11:19 INFO - 'MAIL': '/var/mail/cltbld', 20:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:19 INFO - 'MOZ_NO_REMOTE': '1', 20:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:19 INFO - 'NO_EM_RESTART': '1', 20:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:19 INFO - 'PWD': '/builds/slave/test', 20:11:19 INFO - 'SHELL': '/bin/bash', 20:11:19 INFO - 'SHLVL': '1', 20:11:19 INFO - 'TERM': 'linux', 20:11:19 INFO - 'TMOUT': '86400', 20:11:19 INFO - 'USER': 'cltbld', 20:11:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:19 INFO - '_': '/tools/buildbot/bin/python'} 20:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:19 INFO - Running setup.py (path:/tmp/pip-v3iwvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:19 INFO - Running setup.py (path:/tmp/pip-9wKP3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:19 INFO - Running setup.py (path:/tmp/pip-k9qtiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:19 INFO - Running setup.py (path:/tmp/pip-8_DG9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:19 INFO - Running setup.py (path:/tmp/pip-PkHQ1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:19 INFO - Running setup.py (path:/tmp/pip-ZLIXd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:19 INFO - Running setup.py (path:/tmp/pip-nOjcgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:19 INFO - Running setup.py (path:/tmp/pip-BQ96lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:20 INFO - Running setup.py (path:/tmp/pip-o5Yl51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:20 INFO - Running setup.py (path:/tmp/pip-gUelvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:20 INFO - Running setup.py (path:/tmp/pip-HqTHgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:20 INFO - Running setup.py (path:/tmp/pip-hvso1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:20 INFO - Running setup.py (path:/tmp/pip-VIPTNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:20 INFO - Running setup.py (path:/tmp/pip-2nnX5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:20 INFO - Running setup.py (path:/tmp/pip-EIeMcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:20 INFO - Running setup.py (path:/tmp/pip-RluWoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:20 INFO - Running setup.py (path:/tmp/pip-QVgnH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:20 INFO - Running setup.py install for manifestparser 20:11:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:20 INFO - Running setup.py install for mozcrash 20:11:20 INFO - Running setup.py install for mozdebug 20:11:20 INFO - Running setup.py install for mozdevice 20:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for mozfile 20:11:21 INFO - Running setup.py install for mozhttpd 20:11:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for mozinfo 20:11:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for mozInstall 20:11:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for mozleak 20:11:21 INFO - Running setup.py install for mozlog 20:11:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for moznetwork 20:11:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:21 INFO - Running setup.py install for mozprocess 20:11:21 INFO - Running setup.py install for mozprofile 20:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:22 INFO - Running setup.py install for mozrunner 20:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:22 INFO - Running setup.py install for mozscreenshot 20:11:22 INFO - Running setup.py install for moztest 20:11:22 INFO - Running setup.py install for mozversion 20:11:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:22 INFO - Cleaning up... 20:11:22 INFO - Return code: 0 20:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:22 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 20:11:22 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 20:11:22 INFO - Using env: {'DISPLAY': ':0', 20:11:22 INFO - 'HOME': '/home/cltbld', 20:11:22 INFO - 'LANG': 'en_US.UTF-8', 20:11:22 INFO - 'LANGUAGE': 'en_US:en', 20:11:22 INFO - 'LOGNAME': 'cltbld', 20:11:22 INFO - 'MAIL': '/var/mail/cltbld', 20:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:22 INFO - 'MOZ_NO_REMOTE': '1', 20:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:22 INFO - 'NO_EM_RESTART': '1', 20:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:22 INFO - 'PWD': '/builds/slave/test', 20:11:22 INFO - 'SHELL': '/bin/bash', 20:11:22 INFO - 'SHLVL': '1', 20:11:22 INFO - 'TERM': 'linux', 20:11:22 INFO - 'TMOUT': '86400', 20:11:22 INFO - 'USER': 'cltbld', 20:11:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:22 INFO - '_': '/tools/buildbot/bin/python'} 20:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:22 INFO - Running setup.py (path:/tmp/pip-PBUfdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:22 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)) 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:22 INFO - Running setup.py (path:/tmp/pip-Oe8hpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:22 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)) 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:22 INFO - Running setup.py (path:/tmp/pip-A3LfKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:22 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)) 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:22 INFO - Running setup.py (path:/tmp/pip-93kp0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:22 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)) 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:22 INFO - Running setup.py (path:/tmp/pip-Izn8TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:23 INFO - Running setup.py (path:/tmp/pip-orP14K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:23 INFO - Running setup.py (path:/tmp/pip-brdxzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:23 INFO - Running setup.py (path:/tmp/pip-wwlFsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:23 INFO - Running setup.py (path:/tmp/pip-5kJRFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:23 INFO - Running setup.py (path:/tmp/pip-rvdCtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:23 INFO - Running setup.py (path:/tmp/pip-ANRixA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:23 INFO - Running setup.py (path:/tmp/pip-DBfxLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:23 INFO - Running setup.py (path:/tmp/pip-48EApG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:23 INFO - Running setup.py (path:/tmp/pip-iqakNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:23 INFO - Running setup.py (path:/tmp/pip-7R4P0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:23 INFO - Running setup.py (path:/tmp/pip-qpGCV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:23 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)) 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:23 INFO - Running setup.py (path:/tmp/pip-1BZEgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:23 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)) 20:11:23 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)) 20:11:23 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)) 20:11:23 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)) 20:11:23 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)) 20:11:23 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)) 20:11:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:25 INFO - Downloading blessings-1.6.tar.gz 20:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:25 INFO - Installing collected packages: blessings 20:11:25 INFO - Running setup.py install for blessings 20:11:25 INFO - Successfully installed blessings 20:11:25 INFO - Cleaning up... 20:11:26 INFO - Return code: 0 20:11:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:26 INFO - Reading from file tmpfile_stdout 20:11:26 INFO - Current package versions: 20:11:26 INFO - argparse == 1.2.1 20:11:26 INFO - blessings == 1.6 20:11:26 INFO - blobuploader == 1.2.4 20:11:26 INFO - docopt == 0.6.1 20:11:26 INFO - manifestparser == 1.1 20:11:26 INFO - mozInstall == 1.12 20:11:26 INFO - mozcrash == 0.17 20:11:26 INFO - mozdebug == 0.1 20:11:26 INFO - mozdevice == 0.48 20:11:26 INFO - mozfile == 1.2 20:11:26 INFO - mozhttpd == 0.7 20:11:26 INFO - mozinfo == 0.9 20:11:26 INFO - mozleak == 0.1 20:11:26 INFO - mozlog == 3.1 20:11:26 INFO - moznetwork == 0.27 20:11:26 INFO - mozprocess == 0.22 20:11:26 INFO - mozprofile == 0.28 20:11:26 INFO - mozrunner == 6.11 20:11:26 INFO - mozscreenshot == 0.1 20:11:26 INFO - mozsystemmonitor == 0.0 20:11:26 INFO - moztest == 0.7 20:11:26 INFO - mozversion == 1.4 20:11:26 INFO - psutil == 3.1.1 20:11:26 INFO - requests == 1.2.3 20:11:26 INFO - wsgiref == 0.1.2 20:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:26 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 20:11:26 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 20:11:26 INFO - Using env: {'DISPLAY': ':0', 20:11:26 INFO - 'HOME': '/home/cltbld', 20:11:26 INFO - 'LANG': 'en_US.UTF-8', 20:11:26 INFO - 'LANGUAGE': 'en_US:en', 20:11:26 INFO - 'LOGNAME': 'cltbld', 20:11:26 INFO - 'MAIL': '/var/mail/cltbld', 20:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:26 INFO - 'MOZ_NO_REMOTE': '1', 20:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:26 INFO - 'NO_EM_RESTART': '1', 20:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:26 INFO - 'PWD': '/builds/slave/test', 20:11:26 INFO - 'SHELL': '/bin/bash', 20:11:26 INFO - 'SHLVL': '1', 20:11:26 INFO - 'TERM': 'linux', 20:11:26 INFO - 'TMOUT': '86400', 20:11:26 INFO - 'USER': 'cltbld', 20:11:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:26 INFO - '_': '/tools/buildbot/bin/python'} 20:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 INFO - Cleaning up... 20:11:26 INFO - Return code: 0 20:11:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:11:26 INFO - Using env: {'DISPLAY': ':0', 20:11:26 INFO - 'HOME': '/home/cltbld', 20:11:26 INFO - 'LANG': 'en_US.UTF-8', 20:11:26 INFO - 'LANGUAGE': 'en_US:en', 20:11:26 INFO - 'LOGNAME': 'cltbld', 20:11:26 INFO - 'MAIL': '/var/mail/cltbld', 20:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:26 INFO - 'MOZ_NO_REMOTE': '1', 20:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:26 INFO - 'NO_EM_RESTART': '1', 20:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:26 INFO - 'PWD': '/builds/slave/test', 20:11:26 INFO - 'SHELL': '/bin/bash', 20:11:26 INFO - 'SHLVL': '1', 20:11:26 INFO - 'TERM': 'linux', 20:11:26 INFO - 'TMOUT': '86400', 20:11:26 INFO - 'USER': 'cltbld', 20:11:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:26 INFO - '_': '/tools/buildbot/bin/python'} 20:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:26 INFO - Downloading/unpacking jsonschema 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:28 INFO - Downloading/unpacking functools32 (from jsonschema) 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:28 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:28 INFO - warning: no files found matching '*.txt' 20:11:28 INFO - no previously-included directories found matching 'build' 20:11:28 INFO - no previously-included directories found matching 'dist' 20:11:28 INFO - no previously-included directories found matching '.git*' 20:11:28 INFO - Installing collected packages: jsonschema, functools32 20:11:28 INFO - Running setup.py install for functools32 20:11:28 INFO - warning: no files found matching '*.txt' 20:11:28 INFO - no previously-included directories found matching 'build' 20:11:28 INFO - no previously-included directories found matching 'dist' 20:11:28 INFO - no previously-included directories found matching '.git*' 20:11:28 INFO - Successfully installed jsonschema functools32 20:11:28 INFO - Cleaning up... 20:11:29 INFO - Return code: 0 20:11:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:11:29 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')]} 20:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:29 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')]} 20:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:29 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 0x7f622fad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', '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 20:11:29 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 20:11:29 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 20:11:29 INFO - Using env: {'DISPLAY': ':0', 20:11:29 INFO - 'HOME': '/home/cltbld', 20:11:29 INFO - 'LANG': 'en_US.UTF-8', 20:11:29 INFO - 'LANGUAGE': 'en_US:en', 20:11:29 INFO - 'LOGNAME': 'cltbld', 20:11:29 INFO - 'MAIL': '/var/mail/cltbld', 20:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:29 INFO - 'MOZ_NO_REMOTE': '1', 20:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:29 INFO - 'NO_EM_RESTART': '1', 20:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:29 INFO - 'PWD': '/builds/slave/test', 20:11:29 INFO - 'SHELL': '/bin/bash', 20:11:29 INFO - 'SHLVL': '1', 20:11:29 INFO - 'TERM': 'linux', 20:11:29 INFO - 'TMOUT': '86400', 20:11:29 INFO - 'USER': 'cltbld', 20:11:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:29 INFO - '_': '/tools/buildbot/bin/python'} 20:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:29 INFO - Downloading/unpacking flake8 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:11:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:11:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:31 INFO - no previously-included directories found matching 'docs/_build' 20:11:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:11:31 INFO - Running setup.py install for pep8 20:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:31 INFO - no previously-included directories found matching 'docs/_build' 20:11:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:11:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:11:31 INFO - Cleaning up... 20:11:32 INFO - Return code: 0 20:11:32 INFO - Running post-action listener: _resource_record_post_action 20:11:32 INFO - Running post-action listener: _start_resource_monitoring 20:11:32 INFO - Starting resource monitoring. 20:11:32 INFO - ##### 20:11:32 INFO - ##### Finished create-virtualenv step (success) 20:11:32 INFO - ##### 20:11:32 INFO - ##### 20:11:32 INFO - ##### Running install step. 20:11:32 INFO - ##### 20:11:32 INFO - Running pre-action listener: _resource_record_pre_action 20:11:32 INFO - Running main action method: install 20:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:32 INFO - Reading from file tmpfile_stdout 20:11:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:32 INFO - Reading from file tmpfile_stdout 20:11:32 INFO - Output received: 20:11:32 INFO - Usage: mozinstall [options] installer 20:11:32 INFO - Options: 20:11:32 INFO - -h, --help show this help message and exit 20:11:32 INFO - -d DEST, --destination=DEST 20:11:32 INFO - Directory to install application into. [default: 20:11:32 INFO - "/builds/slave/test"] 20:11:32 INFO - --app=APP Application being installed. [default: firefox] 20:11:32 INFO - mkdir: /builds/slave/test/build/application 20:11:32 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'] 20:11:32 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 20:11:48 INFO - Reading from file tmpfile_stdout 20:11:48 INFO - Output received: 20:11:48 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:48 INFO - Running post-action listener: _resource_record_post_action 20:11:48 INFO - ##### 20:11:48 INFO - ##### Finished install step (success) 20:11:48 INFO - ##### 20:11:48 INFO - ##### 20:11:48 INFO - ##### Running run-tests step. 20:11:48 INFO - ##### 20:11:48 INFO - Running pre-action listener: _resource_record_pre_action 20:11:48 INFO - Running main action method: run_tests 20:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:48 INFO - Python 2.7.3 20:11:48 INFO - Return code: 0 20:11:48 INFO - grabbing minidump binary from tooltool 20:11:48 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')]} 20:11:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c249c0>, '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 0x2c258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c25d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:48 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 20:11:48 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 20:11:48 INFO - Calling ['/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'] with output_timeout 600 20:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:49 INFO - Return code: 0 20:11:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:11:49 INFO - Return code: 0 20:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 20:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 20:11:49 INFO - Using env: {'DISPLAY': ':0', 20:11:49 INFO - 'HOME': '/home/cltbld', 20:11:49 INFO - 'LANG': 'en_US.UTF-8', 20:11:49 INFO - 'LANGUAGE': 'en_US:en', 20:11:49 INFO - 'LOGNAME': 'cltbld', 20:11:49 INFO - 'MAIL': '/var/mail/cltbld', 20:11:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:49 INFO - 'MOZ_NO_REMOTE': '1', 20:11:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:49 INFO - 'NO_EM_RESTART': '1', 20:11:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:49 INFO - 'PWD': '/builds/slave/test', 20:11:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:49 INFO - 'SHELL': '/bin/bash', 20:11:49 INFO - 'SHLVL': '1', 20:11:49 INFO - 'TERM': 'linux', 20:11:49 INFO - 'TMOUT': '86400', 20:11:49 INFO - 'USER': 'cltbld', 20:11:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145', 20:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:49 INFO - '_': '/tools/buildbot/bin/python'} 20:11:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 20:11:50 INFO - mozversion application_buildid: 20160510173021 20:11:50 INFO - mozversion application_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:11:50 INFO - mozversion application_display_name: Nightly 20:11:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:50 INFO - mozversion application_name: Firefox 20:11:50 INFO - mozversion application_remotingname: firefox 20:11:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:11:50 INFO - mozversion application_vendor: Mozilla 20:11:50 INFO - mozversion application_version: 49.0a1 20:11:50 INFO - mozversion platform_buildid: 20160510173021 20:11:50 INFO - mozversion platform_changeset: 027b0144a1a6c2d62dfb1656e41597acfe6a22ef 20:11:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:11:50 INFO - mozversion platform_version: 49.0a1 20:11:50 INFO - using testdate: 1462936310 20:11:50 INFO - actual date: 1462936310 20:11:50 INFO - starting webserver on 'localhost:53805' 20:11:50 INFO - SUITE-START | Running 2 tests 20:11:50 INFO - TEST-START | dromaeo_css 20:11:50 INFO - operating with platform_type : linux_ 20:11:50 INFO - Initialising browser for dromaeo_css test... 20:11:50 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpev__T0/profile http://localhost:53805/getInfo.html) 20:11:53 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 20:11:53 INFO - PROCESS | 1647 | colorDepth:24 20:11:53 INFO - PROCESS | 1647 | Browser inner width/height: 1024/697 20:11:53 INFO - PROCESS | 1647 | __metrics 20:11:54 ERROR - PROCESS | 1647 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:11:55 INFO - TEST-INFO | 1647: exit 0 20:11:55 INFO - Browser initialized. 20:11:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:55 INFO - TEST-INFO | started process 1732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpev__T0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:07 INFO - PROCESS | 1732 | RSS: Main: 152571904 20:12:07 INFO - PROCESS | 1732 | 20:12:58 INFO - PROCESS | 1732 | 1462936378728 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] 20:15:06 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53805/tests/dromaeo/cssquery-ext.html) 20:15:07 INFO - PROCESS | 1732 | RSS: Main: 254738432 20:15:07 INFO - PROCESS | 1732 | 20:18:10 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-ext.html (next: http://localhost:53805/tests/dromaeo/cssquery-jquery.html) 20:18:10 INFO - PROCESS | 1732 | RSS: Main: 236732416 20:18:10 INFO - PROCESS | 1732 | 20:21:12 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53805/tests/dromaeo/cssquery-mootools.html) 20:21:13 INFO - PROCESS | 1732 | RSS: Main: 235958272 20:21:13 INFO - PROCESS | 1732 | 20:24:15 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53805/tests/dromaeo/cssquery-prototype.html) 20:24:15 INFO - PROCESS | 1732 | RSS: Main: 235855872 20:24:15 INFO - PROCESS | 1732 | 20:27:18 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53805/tests/dromaeo/cssquery-yui.html) 20:27:19 INFO - PROCESS | 1732 | RSS: Main: 224862208 20:27:19 INFO - PROCESS | 1732 | 20:30:21 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:53805/tests/dromaeo/cssquery-yui.html (next: http://localhost:53805/tests/dromaeo/cssquery-dojo.html) 20:30:22 INFO - PROCESS | 1732 | RSS: Main: 270671872 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | __start_tp_report 20:30:22 INFO - PROCESS | 1732 | _x_x_mozilla_page_load 20:30:22 INFO - PROCESS | 1732 | _x_x_mozilla_page_load_details 20:30:22 INFO - PROCESS | 1732 | |i|pagename|runs| 20:30:22 INFO - PROCESS | 1732 | |0;dojo.html;3066.7699922505803;3103.549985252137;3125.9843700781494;3189.394015137124;3219.9356012879734;5317;5348.144296912495;5455.072637651599;5558.527525160362;5603.047481928077;5483.122700367942;5507.008738427082;5581.107022876341;5594.104943209088;5666.9433305666935;4910.901781964368;4966.751662416865;4980.626453016021;5002.199648056312;5116.948830511685;5019.874503137415;5074.061298659742;5078.898422031557;5110.565601923841;5111.02890450815;4912.38595175603;4934.55588996992;4944.085344211297;5013.849584512471;5063.949360506384;4939.036887806879;4994.101061808873;4997.525235102659;5013.273075404082;5062.519060689228;4978.079055374767;4989.351384320052;4995.100881841267;4999.8000079996755;5041.294218809369;5251.947480525184;5420.7018613976215;5471.753771080271;5500.3949565547755;5560.304961879765;5929.169916211734;5942.257217847769;5974.8506287342725;5999.76000959961;6022.217111775485;5707.172459993278;5958.851028724273;5963.433473820023;6037.728302226366;6041.093835924603;5522.66863988162;5573.331200255955;5575.303087114111;5597.6641401516035;5645.745941432645;6046.062860256668;6055.08605329431;6076.351016360932;6109.236345456818;6111.113888486145;5656.773729050792;5730.283714535683;5868.471837534642;5913.674747888907;5920.31916329619;5820.505257053198;5864.149698293723;5871.706414679335;5872.324682661549;5930.962081635696;5715.514181294637;5758;5769.394213607595;5771.076627739541;5796.652200867961;5654.830355089354;5717.571182161355;5773.88452230953;5823.126531020381;5830.53355731549;4389.253826849444;4401.383806267125;4401.6698747594055;4436.6672499562665;4437.023854751949;3901.9609803902167;3925;3925.2345792570177;3943.191645712622;3946.7039972002217;5340.519353258225;5384.6769193848495;5442.156465747816;5450.209719590637;5515.117581187071;5929.37741537141;5950.642961422329;5976.103584462366;5986.191864098291;6014.488768454643;5505.339359276913;5556.91664625031;5564.638298510584;5566.304211973504;5569.303837020372;4799.136155491975;4887.633427492952;4911.312416261726;4918.55732984026;4932.704037757746;6095.238095238095;6098.207233059674;6102.938970610237;6105.755769769248;6111.724972376253;5741.425857414225;5885.735141918538;5888.852778680567;5915.733791979457;5916.49709774674;5946.226990491208;6005.249343832021;6016.037434010537;6017.699115044143;6036.0644100164545;5710.743016564182;5723.885522289447;5724.198612194379;5729.71351432435;5731.770729170787;5735.082386818089;5847.736851841592;5850.619709718854;5856.4143585641095;5863.677497737494;5721.7425215866215;5768.1636162757;5784.045632470764;5788.363280039276;5845.298564172326;5690.374058853606;5735.197072409783;5750.568707347049;5751.281089863767;5776.306843178845;5433.864153396196;5601.60788744784;5636.436356364495;5675.971620142038;5691.573132015198;5824.563157763269;5860.033094539353;5861.032929566573;5870.119482077723;5872.236609240771;5640.210370548045;5646.971765141148;5682.829515114553;5684.8010319638615;5697.031504644303 20:30:22 INFO - PROCESS | 1732 | |1;ext.html;603.399617380706;613.8311964209843;640.9935900640992;647.1619253067278;659.274797722505;34535.654643453556;44021;44987.77506112465;44988.77505612475;47827.52172478274;44009;44219.77890110553;44538.77730611342;44571.33143002858;44669.32996005063;8756.956215218916;8924.776880577972;8926.955365223197;8936.687215947442;8937.195652391283;8758.693445729401;8791.560421978907;8885.289176865836;8887.644494220256;8892.377533572653;8787.692430764924;8839.116088391174;8920.46477211366;8926.687565935194;8940.284777217807;8831.470111793313;8837.60230789616;8851.690190843321;8875.689350872688;8876.999999999967;8699.478031318142;8768.956155219246;8845.955770221171;8852.734417967471;8864.645414183426;41213.38179927303;41596.37605435921;41603.7919810399;41635;41679;3518.2084031093054;3678.70570354371;3766.0584853786554;3927.4501569780255;4301.483821941356;32994.6700532994;33040.50439243413;33266.83366583176;33394.49908251378;33632.15919602005;4320.6327462165755;4391.674344419033;4427.645788336958;4430.556944305576;4467.709598876095;290902;291050;294185.5290723554;296014;297330;56465.71767141138;62658;63042;63327.36672633307;63545.68227158927;56808.43191568114;58174.709126454094;58195;58200.4179958195;58252.70873645604;14574.41702331916;14588.197649129188;14635.634109147357;14675.77986330206;14681.559553213421;11273.323600583992;11291.096712262999;11334.149938754626;11338.376389298668;11369.09047276216;19971.301004464774;20656.690149647766;20987.79012209889;21000.474988125417;21089.367318980454;7494.737684181027;7570.470067095361;7655.272749088827;7932.56619215839;8078.394120440873;985.261054209343;1122.9157813164045;1171.039747407118;1176.0885313881638;1193.6001439517686;32957.835210823796;33264.501032484535;33289.83355083209;33290;33852.32295354079;1165.3975783297965;1177.8645455772696;1193.9462724177433;1194.5580135349976;1244.539520377466;17147.914260428868;17504.737428938577;17581;17603.64500871052;17991.190396432194;441709;611734;620144;622169;860627;59577.70211148917;59992;60178.69910650419;60277.09584356238;60286.39713602896;1419.4811551639646;1427.4932398998205;1435.7487439698011;1436.3321055709146;1447.131720967432;31622.525662115546;34175.829120854236;34180.65819341874;34214.486782698776;34438;50708;50914;51133.11969123598;51196.74401627968;51385.48614513956;438614;441971;441990;442173;442624;25618.487630246917;26509.867450662623;26645.200643980712;26723.866380667972;27256.318592034564;45924.54075459336;46207.53792462167;46433.76783116063;46672.29991550197;47125.29312060391;38977;39010.41484377794;39523.40714889336;39640.60359396369;40181.598184017785;37845;38745.6125438742;38784.80607596944;39112.6088739109;39631.40552891767;39762;39962.2007559853;44130.55869441265;44918.32622510599;45137.548624513336;35386.646133538336;37192.83238259084;37241.068973275884;37681;38455.80772096122;28556.286092847844;29175;29202.269943251587;29205;29249.7075029247 20:30:22 INFO - PROCESS | 1732 | |2;jquery.html;374.46264610284226;376.1142509390386;377.5714563969895;389.25457748411793;394.71186034195034;14737.926310368433;16784.832151678478;18586.256549738013;19712.112954917025;19743.703844442327;16598.170091495438;17678.116094195302;17846;17876.82123178768;19751.40745777629;5596.692181930002;5674.177244299574;5741.167530708045;5775.27809023872;5777.884442311151;5550.888982220353;5607.943920560803;5695.572832037593;5715.114157305624;5726.255586773714;5568.192612071247;5610.887782244353;5652.039153343921;5654.236678048473;5655.151727240926;5701.714914254291;5703.971480142614;5709.200711900337;5711.343195532505;5715.3141623005295;4892.755362231874;4911.189653707134;4950.059488697172;5104.872378190538;5109.897802043938;22914.54170916589;23392.76607233923;23406.64890026651;23412;23495.647565286534;2501.7248102708686;2668.613051107598;2783.3320003199287;2881.4813333599946;2917.2706823294175;14343.21112338821;14456.421743130262;14467.204303763288;14773.852261477356;15266.618334541614;1818.3908390689135;1958.5886963737632;1967.980320196794;2004.3886614582545;2058.7014882841904;72687;75872.62063689702;76267;77055.61472192603;79860.20139798644;10762.3542587445;10921.290116142425;10969.561217551209;11106.500207490682;11232.3260604364;15479.380824767108;15586.06483610987;15617.76573351378;15636.530904072895;15660.373585056697;7636.160022397532;7695.538267703956;7910.248526389983;7985.560794156378;8026.036875574969;7273.309035641606;7347.265273472717;7400.777976660709;7518.887216691754;7521.623918804038;4743.525647435229;4773.212419950739;4792.640551958617;4820.4456487503685;4841.225403935354;1936.4868309897888;1946.7079938009413;1974.4372853736616;1994.1524851937868;2007.6687346587942;991.5538007896475;1068.56188962525;1110.3670907582762;1131.1878967878304;1153.210051114989;18809.623807523774;19200;19215.615687686448;19383.127759250867;19466.60452478803;979.9020097990144;985.0592683986775;1018.7962407518526;1044.8611013994782;1048.486241741541;10441.381585854204;10555.84166237507;10952.726181845359;10957.945210274058;11003.284786488852;455829.72085139365;458320;470319;484340;484950;92882;95092.52453737687;97534.51232743933;97808;98004.50997745109;1005.8088963096989;1012.3015119567622;1028.9125424339015;1040.5889673579045;1052.2791887557048;16741.1629418531;16839.747403788708;16956.66086678284;17287.913560432116;17846.929184248987;26556.336091597863;28317;38112.809435952644;39675.82734671873;41406.79296603498;57160;58490;58499.4150058494;58537.70731146317;59584;8387.161283871565;8624.741257762276;8681.479111253346;8833.249173820297;8861.689840855539;11556.191066625255;12692.492300307884;12775;12876.291803950873;12898.484060637844;11128.221024528206;11224.607138750105;11417.771644567229;11484.885151148716;11553.133514986577;10692.14462842955;10879.347239165676;11148.163887708291;11272;11409.60066397672;11292.701339345751;11569.132315076235;11622;11700.941495292469;11727.061835053346;8458;8488.363372747192;8630.654773808978;8668.869966950375;8698.695545655872;10581.31221470602;11129.220954533104;11220.270682405617;11549.769004620028;11660.06719462424 20:30:22 INFO - PROCESS | 1732 | |3;mootools.html;1394.5398018653846;1527.5177836016474;1552.8369521200273;1581.9999999999993;1600.8479194476524;8396.874046889294;8722.345824063188;8734.301255899521;9030.72907812765;9031;8748.212660860521;8929.776755581113;8932.419392739468;8935.776605584864;8944.59749311281;2049.7437820272467;2203.6694495825595;2240.451089483075;2256.1539422716482;2272.0798076778933;2260.954780904381;2262.6266666000092;2264.298067599041;2270.6821045053625;2277.806386457153;2243.932682019534;2257.16484900587;2267.546490701858;2267.9886600567056;2272.681824544565;1946.6106778644257;2004.9398518044482;2006.528465810548;2064.7935206479383;2177.640689286266;2198.2416066457045;2230.4869879927705;2235.35174799308;2235.6870038194666;2241.6189247827747;8284.25441710249;8341.165883411672;8344.541050242235;8349.03986041601;8361.874571881426;5113.744312784346;5226.738663066832;5255.421903590602;5271.920921186185;5280.102382594968;3315.784474009182;3398.2863598644312;3429.6227414984332;3436.2096717754807;3439.4152993991083;1023.8361862102103;1034.4052170002203;1034.4982683398546;1035.7203555040096;1036.8652075230248;12473.812892806614;12474.937625311906;12479.251244925334;12488.12583119182;12502.874971250261;4556.2254416748565;4615.607673347736;4653.395058642423;4715.481297057321;4735.195016847144;10460;10473.738156545995;10479.580816767397;10491.055804977588;10541.420221887869;5205.55752761012;5207.3490813648295;5209.218617207373;5210.6873587584105;5211.895762084813;4294.570542945743;4779.593734532604;4909.993451342466;4919.114559379274;4992.650514464025;3890.319194141014;3937.5078115235597;3973.6821054315587;4009.558948515661;4040.6363427291685;1244.5581818454318;1263.7662032524013;1275.6236910111538;1284.088297308921;1290.393515047926;1030.5723124903081;1046.8115739166872;1049.2550289294686;1063.5533076108054;1064.7125276175543;6033.3966603340195;6126.387361263927;6163.260408750979;6172.753089876354;6332.398422149889;439.8966242932908;445.1853108810868;446.48654047845235;449.5212598582499;458.72018068977894;3981.6217459341315;4143.7720925349395;4160.729552579072;4225.704200705921;4305.784710764449;10455.372677639367;10475.16198704117;10811.459427028618;11039.779204415867;11058.612948546763;11030.889691103146;11058.11535077192;11152.721181970515;11154.330740155616;11219.046381057702;8129.634166462523;8262.504249745034;8350.66597336112;8356.122607126164;8451;6045.093236014633;6277.905831412624;6287.528435367457;6469.094326794158;6494.512911531749;9612.66355677548;10233.641822536176;10329.225308101772;10356.844647330447;10463;10157.492125393848;10583;10731.785364292826;10745.516451759846;10750.408727520062;7090.787276381717;7511.549307041595;7740.535567865946;7761.379089672925;7807.843843123219;8729.127087291221;8771.473711577326;8793.076726943578;8902.910970890209;8903.154200350957;7633.69465221385;7743.961280193563;7835.764927052198;7982.920170798217;8064;7616.0860696716745;7622.123455802432;7696.345810605937;7716.691332346643;7743.4966727162555;7049.753258635923;7052.929470705228;7111.751088711871;7131.465140114616;7142.178649455379;5012.598992080698;5125.974370128126;5160.09698302803;5244.292020577173;5266.34170728659;5022.17134172872;5118.692878427306;5145.562627176732;5199.376074871039;5275.630705850554 20:30:22 INFO - PROCESS | 1732 | |4;prototype.html;312.41890084442946;320.18353199341675;322.16559111900176;329.2805220593006;330.55540298298797;5213.2701421800975;5264.605154613405;5310.468953104688;5322.494363035516;5438.293021907151;5268.262443257938;5281.815136470224;5285.365756109262;5294.814681486148;5303.973480132604;4119.155573107506;4137.1725654869;4173.457450531434;4175.519815221242;4187.476565429321;4028.5971402859627;4173.624373806357;4195.433616461784;4205.11692544566;4213.2837417639075;4128.938065929014;4155.937660935088;4161.875143745692;4166.729162604436;4180.205760905418;4154.273002224613;4163.146554956226;4168.832726836491;4178.227027999815;4183.99999999997;3737.0380550211084;3738.831752571141;3746.4942232798494;3761.54861416629;3782.71629627779;5071.920512589857;5144.61415393847;5151.356080489939;5182.222666600002;5211.374635043781;4767.928481072787;4770.618350531984;4777.498362671904;4782.115308667872;4782.354382158399;5415;5553.72231388433;5565.777368905239;5571.0807716726695;5581.916271255935;4089.7137200395982;4095.344744840841;4095.9795201024103;4096.078382363974;4109.589041095896;5547.223388725582;5582.330120385539;5811.506021988136;5835.649861008353;5844.123381492767;4106.260873042821;4118.341065429517;4118.794060296973;4121.5878412158545;4125.133721918371;4151.481064866892;4184.163167366539;4189.120284740238;4192.874213773592;4195.433616461739;4498.145352383037;4589.5639914208095;4722.598579120813;4762.4285085789925;4784.880377990578;5460.34475862899;5502.331369285893;5518.668879867221;5565.805196818092;5566.137248726453;1430.3777856632398;1445.756649281617;1448.8478709735537;1450.2893582144884;1453.3024148408822;906.3791302957495;951.8477043672979;952.4665288884889;955.7945041816043;965.478641533564;4776.47458779534;4807.495213002584;4815.975920120377;4827.686200397034;4831.275308703653;5055.620828437882;5063.569596584258;5079.593632509391;5124.615653825978;5136.640435169502;4509.210888094571;4776.5701086902345;4780.139574876555;4803.879903002383;4829.95170048302;2684.6644169478814;2686.3955609987597;2689.3729293777374;2692.4749673813417;2703.9324016899736;5121.926843893634;5151.8196863109615;5153.433122356538;5163.741812909339;5172.956682110545;4861.416630004422;5054.6134090159685;5099.311592934906;5124;5165.9225111623355;5139;5164.715940623227;5168.483151684876;5169.991851588904;5202.76587553561;4956.132676781477;4975.402951645681;5019.32239147725;5053.357658760844;5070.290159377616;4720.645951553579;4900.95099049005;4971.801127954841;4982.55505903284;5421.322334708161;5688.520984543966;5801;5820.330661973927;5823.602335439548;5824.70876456167;4107.9178416432105;4113.71204015716;4117.197146556393;4140.171965606831;4159.188958153131;5649.322081350264;5771.9134212986;5791.739371728367;5796.275465566804;5803.158542011469;5499.2576002240785;5574.777008919597;5621.606487545832;5629.324481062299;5639.2668953035845;5477.75350109238;5523.530499907552;5555.944440555542;5590.972045139748;5596.580256480862;5251.238570407193;5438.510534051954;5453.863653408696;5490.368607610176;5510.752016159202;5559.777608895599;5567.164925261243;5599.272094627672;5635.239242702347;5682.289713785777;5234.031704134747;5530.695811730394;5532.114861622121;5538.196961440649;5556.666600004012 20:30:22 INFO - PROCESS | 1732 | |5;yui.html;844.497523973236;853.3812985585447;870.618857424943;874.7681864305956;885.4642941020684;14755.336009879555;15265.465708700198;15272.541823745278;15275.77086343703;15277.694446111085;13762.24307663078;14233.857661423383;14248.857511424883;14268;14268.71462570748;846.1284876577135;851.4423052900329;854.5599016506504;854.9615267312986;859.1322764008335;707.345705222667;841.1924552429645;854.5257382152903;864.1790299215738;866.4714524140269;898.8966268879065;901.5131828812433;904.0326850270213;905.9456432614031;907.5734404829719;734.8420089680691;900.3832374823235;901.0538934119214;903.6746771162376;903.7153296711581;618.2086928731231;629.0093103362223;631.6810010944489;635.7234602947733;636.1189752193245;14250.073745206528;14329.78505322421;14354.354054067488;14361.569152925429;14396.928015359961;13566.525171618947;13969.371378288002;13991.790123148161;14132.152070875678;14151.29243537819;11993.580224692181;12016.819747703792;12235.086536745905;12273.079519036108;12455.314957677325;4440.400545926291;4527.298268768346;4536;4569.634429245685;4640.79116439761;50119.49880501185;50454.7477262615;50657.24014139791;51883.74058129685;52180.47819521832;10512.526936287886;10607.15142788575;10662.733431664115;11006.284591501688;11315.151363647594;18533.166007529693;18936.43190704281;18945.43163705091;19432.514187145436;19917.60164796725;8486.108958559385;8545.658173673108;8556.74329770108;8605.913940860637;8730.607122679494;4918.90162196754;4949.257611358253;5071.5689166420525;5167.819126330561;5195.220716892496;3230.6123265208325;3313;3335.949960750591;3336.0158753167875;3336.4828451590042;662.4733336997099;664.2560332427615;667.0494545272967;669.7019826177402;672.3022385284673;631.9715612797435;749.2245525880687;753.3348182245629;784.9489783164076;812.975610731679;9117.407368521157;9426.717198484057;9682.225421966226;9759.756006099762;9799.657012004545;739.3198257603018;780.7072347869549;781.3468317278379;791.70311133325;807.9192080791873;4505.864824055218;4513.72917624937;4516.16450956574;4589.265717485253;4589.57106392333;48731;50065.446987939154;50464.747676262115;50711.7464412683;50778;53337.73331133397;53501.1974820378;56010.15984760232;57427.42572574304;57578;50238.748806256466;50334.49665503298;50378.24432633514;50503.747481262355;51612.48387516152;8756.124387561193;8893.73318800437;8894.644214231359;8903.554822258991;9094.669690248895;32469.51295730613;32702.672973269964;32803.22762882299;32852.178695532806;33784.831075845446;42134.78932605317;45124.58504979424;45418.09163816771;45783.54216457926;46039.539604603524;11597.76804463923;11852.466639001093;12129.272243665408;12236.327002014974;12279;13646.181229126285;13829.861701382857;13967.231802250973;14146.92926535402;14317.856821431653;13001.804972925225;13302.866971330162;13606.795898061735;13657.453701851815;14025.29873506341;13141.34293285351;13286;13427.395767190304;13499.662508437368;13747.037707360789;13152.408141633457;13683.179009259078;13710.725785484434;13889.861101388857;13922.234277114856;10978.176636752116;11121.944390277997;11175.49710263024;11295.265807722471;11429.371384573928;11315.547378104784;11502.942485287855;11635.185537012328;11676.124290678063;11795.174337796272 20:30:22 INFO - PROCESS | 1732 | __end_tp_report 20:30:22 INFO - PROCESS | 1732 | __start_cc_report 20:30:22 INFO - PROCESS | 1732 | _x_x_mozilla_cycle_collect,871 20:30:22 INFO - PROCESS | 1732 | __end_cc_report 20:30:22 INFO - PROCESS | 1732 | __startTimestamp1462937422079__endTimestamp 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | ------- Summary: start ------- 20:30:22 INFO - PROCESS | 1732 | Number of tests: 6 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#0] dojo.html Cycles:165 Average:5448.98 Median:5675.97 stddev:639.44 (11.3%) stddev-sans-first:613.48 20:30:22 INFO - PROCESS | 1732 | Values: 3066.8 3103.5 3126.0 3189.4 3219.9 5317.0 5348.1 5455.1 5558.5 5603.0 5483.1 5507.0 5581.1 5594.1 5666.9 4910.9 4966.8 4980.6 5002.2 5116.9 5019.9 5074.1 5078.9 5110.6 5111.0 4912.4 4934.6 4944.1 5013.8 5063.9 4939.0 4994.1 4997.5 5013.3 5062.5 4978.1 4989.4 4995.1 4999.8 5041.3 5251.9 5420.7 5471.8 5500.4 5560.3 5929.2 5942.3 5974.9 5999.8 6022.2 5707.2 5958.9 5963.4 6037.7 6041.1 5522.7 5573.3 5575.3 5597.7 5645.7 6046.1 6055.1 6076.4 6109.2 6111.1 5656.8 5730.3 5868.5 5913.7 5920.3 5820.5 5864.1 5871.7 5872.3 5931.0 5715.5 5758.0 5769.4 5771.1 5796.7 5654.8 5717.6 5773.9 5823.1 5830.5 4389.3 4401.4 4401.7 4436.7 4437.0 3902.0 3925.0 3925.2 3943.2 3946.7 5340.5 5384.7 5442.2 5450.2 5515.1 5929.4 5950.6 5976.1 5986.2 6014.5 5505.3 5556.9 5564.6 5566.3 5569.3 4799.1 4887.6 4911.3 4918.6 4932.7 6095.2 6098.2 6102.9 6105.8 6111.7 5741.4 5885.7 5888.9 5915.7 5916.5 5946.2 6005.2 6016.0 6017.7 6036.1 5710.7 5723.9 5724.2 5729.7 5731.8 5735.1 5847.7 5850.6 5856.4 5863.7 5721.7 5768.2 5784.0 5788.4 5845.3 5690.4 5735.2 5750.6 5751.3 5776.3 5433.9 5601.6 5636.4 5676.0 5691.6 5824.6 5860.0 5861.0 5870.1 5872.2 5640.2 5647.0 5682.8 5684.8 5697.0 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#1] ext.html Cycles:180 Average:61565.13 Median:22990.24 stddev:128928.16 (560.8%) stddev-sans-first:129208.59 20:30:22 INFO - PROCESS | 1732 | Values: 603.4 613.8 641.0 647.2 659.3 34535.7 44021.0 44987.8 44988.8 47827.5 44009.0 44219.8 44538.8 44571.3 44669.3 8757.0 8924.8 8927.0 8936.7 8937.2 8758.7 8791.6 8885.3 8887.6 8892.4 8787.7 8839.1 8920.5 8926.7 8940.3 8831.5 8837.6 8851.7 8875.7 8877.0 8699.5 8769.0 8846.0 8852.7 8864.6 41213.4 41596.4 41603.8 41635.0 41679.0 3518.2 3678.7 3766.1 3927.5 4301.5 32994.7 33040.5 33266.8 33394.5 33632.2 4320.6 4391.7 4427.6 4430.6 4467.7 290902.0 291050.0 294185.5 296014.0 297330.0 56465.7 62658.0 63042.0 63327.4 63545.7 56808.4 58174.7 58195.0 58200.4 58252.7 14574.4 14588.2 14635.6 14675.8 14681.6 11273.3 11291.1 11334.1 11338.4 11369.1 19971.3 20656.7 20987.8 21000.5 21089.4 7494.7 7570.5 7655.3 7932.6 8078.4 985.3 1122.9 1171.0 1176.1 1193.6 32957.8 33264.5 33289.8 33290.0 33852.3 1165.4 1177.9 1193.9 1194.6 1244.5 17147.9 17504.7 17581.0 17603.6 17991.2 441709.0 611734.0 620144.0 622169.0 860627.0 59577.7 59992.0 60178.7 60277.1 60286.4 1419.5 1427.5 1435.7 1436.3 1447.1 31622.5 34175.8 34180.7 34214.5 34438.0 50708.0 50914.0 51133.1 51196.7 51385.5 438614.0 441971.0 441990.0 442173.0 442624.0 25618.5 26509.9 26645.2 26723.9 27256.3 45924.5 46207.5 46433.8 46672.3 47125.3 38977.0 39010.4 39523.4 39640.6 40181.6 37845.0 38745.6 38784.8 39112.6 39631.4 39762.0 39962.2 44130.6 44918.3 45137.5 35386.6 37192.8 37241.1 37681.0 38455.8 28556.3 29175.0 29202.3 29205.0 29249.7 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#2] jquery.html Cycles:180 Average:28256.85 Median:23453.82 stddev:77760.24 (331.5%) stddev-sans-first:77950.20 20:30:22 INFO - PROCESS | 1732 | Values: 374.5 376.1 377.6 389.3 394.7 14737.9 16784.8 18586.3 19712.1 19743.7 16598.2 17678.1 17846.0 17876.8 19751.4 5596.7 5674.2 5741.2 5775.3 5777.9 5550.9 5607.9 5695.6 5715.1 5726.3 5568.2 5610.9 5652.0 5654.2 5655.2 5701.7 5704.0 5709.2 5711.3 5715.3 4892.8 4911.2 4950.1 5104.9 5109.9 22914.5 23392.8 23406.6 23412.0 23495.6 2501.7 2668.6 2783.3 2881.5 2917.3 14343.2 14456.4 14467.2 14773.9 15266.6 1818.4 1958.6 1968.0 2004.4 2058.7 72687.0 75872.6 76267.0 77055.6 79860.2 10762.4 10921.3 10969.6 11106.5 11232.3 15479.4 15586.1 15617.8 15636.5 15660.4 7636.2 7695.5 7910.2 7985.6 8026.0 7273.3 7347.3 7400.8 7518.9 7521.6 4743.5 4773.2 4792.6 4820.4 4841.2 1936.5 1946.7 1974.4 1994.2 2007.7 991.6 1068.6 1110.4 1131.2 1153.2 18809.6 19200.0 19215.6 19383.1 19466.6 979.9 985.1 1018.8 1044.9 1048.5 10441.4 10555.8 10952.7 10957.9 11003.3 455829.7 458320.0 470319.0 484340.0 484950.0 92882.0 95092.5 97534.5 97808.0 98004.5 1005.8 1012.3 1028.9 1040.6 1052.3 16741.2 16839.7 16956.7 17287.9 17846.9 26556.3 28317.0 38112.8 39675.8 41406.8 57160.0 58490.0 58499.4 58537.7 59584.0 8387.2 8624.7 8681.5 8833.2 8861.7 11556.2 12692.5 12775.0 12876.3 12898.5 11128.2 11224.6 11417.8 11484.9 11553.1 10692.1 10879.3 11148.2 11272.0 11409.6 11292.7 11569.1 11622.0 11700.9 11727.1 8458.0 8488.4 8630.7 8668.9 8698.7 10581.3 11129.2 11220.3 11549.8 11660.1 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#3] mootools.html Cycles:180 Average:5821.04 Median:442.54 stddev:3379.96 (763.8%) stddev-sans-first:3373.08 20:30:22 INFO - PROCESS | 1732 | Values: 1394.5 1527.5 1552.8 1582.0 1600.8 8396.9 8722.3 8734.3 9030.7 9031.0 8748.2 8929.8 8932.4 8935.8 8944.6 2049.7 2203.7 2240.5 2256.2 2272.1 2261.0 2262.6 2264.3 2270.7 2277.8 2243.9 2257.2 2267.5 2268.0 2272.7 1946.6 2004.9 2006.5 2064.8 2177.6 2198.2 2230.5 2235.4 2235.7 2241.6 8284.3 8341.2 8344.5 8349.0 8361.9 5113.7 5226.7 5255.4 5271.9 5280.1 3315.8 3398.3 3429.6 3436.2 3439.4 1023.8 1034.4 1034.5 1035.7 1036.9 12473.8 12474.9 12479.3 12488.1 12502.9 4556.2 4615.6 4653.4 4715.5 4735.2 10460.0 10473.7 10479.6 10491.1 10541.4 5205.6 5207.3 5209.2 5210.7 5211.9 4294.6 4779.6 4910.0 4919.1 4992.7 3890.3 3937.5 3973.7 4009.6 4040.6 1244.6 1263.8 1275.6 1284.1 1290.4 1030.6 1046.8 1049.3 1063.6 1064.7 6033.4 6126.4 6163.3 6172.8 6332.4 439.9 445.2 446.5 449.5 458.7 3981.6 4143.8 4160.7 4225.7 4305.8 10455.4 10475.2 10811.5 11039.8 11058.6 11030.9 11058.1 11152.7 11154.3 11219.0 8129.6 8262.5 8350.7 8356.1 8451.0 6045.1 6277.9 6287.5 6469.1 6494.5 9612.7 10233.6 10329.2 10356.8 10463.0 10157.5 10583.0 10731.8 10745.5 10750.4 7090.8 7511.5 7740.5 7761.4 7807.8 8729.1 8771.5 8793.1 8902.9 8903.2 7633.7 7744.0 7835.8 7982.9 8064.0 7616.1 7622.1 7696.3 7716.7 7743.5 7049.8 7052.9 7111.8 7131.5 7142.2 5012.6 5126.0 5160.1 5244.3 5266.3 5022.2 5118.7 5145.6 5199.4 5275.6 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#4] prototype.html Cycles:180 Average:4543.59 Median:5059.60 stddev:1300.82 (25.7%) stddev-sans-first:1265.11 20:30:22 INFO - PROCESS | 1732 | Values: 312.4 320.2 322.2 329.3 330.6 5213.3 5264.6 5310.5 5322.5 5438.3 5268.3 5281.8 5285.4 5294.8 5304.0 4119.2 4137.2 4173.5 4175.5 4187.5 4028.6 4173.6 4195.4 4205.1 4213.3 4128.9 4155.9 4161.9 4166.7 4180.2 4154.3 4163.1 4168.8 4178.2 4184.0 3737.0 3738.8 3746.5 3761.5 3782.7 5071.9 5144.6 5151.4 5182.2 5211.4 4767.9 4770.6 4777.5 4782.1 4782.4 5415.0 5553.7 5565.8 5571.1 5581.9 4089.7 4095.3 4096.0 4096.1 4109.6 5547.2 5582.3 5811.5 5835.6 5844.1 4106.3 4118.3 4118.8 4121.6 4125.1 4151.5 4184.2 4189.1 4192.9 4195.4 4498.1 4589.6 4722.6 4762.4 4784.9 5460.3 5502.3 5518.7 5565.8 5566.1 1430.4 1445.8 1448.8 1450.3 1453.3 906.4 951.8 952.5 955.8 965.5 4776.5 4807.5 4816.0 4827.7 4831.3 5055.6 5063.6 5079.6 5124.6 5136.6 4509.2 4776.6 4780.1 4803.9 4830.0 2684.7 2686.4 2689.4 2692.5 2703.9 5121.9 5151.8 5153.4 5163.7 5173.0 4861.4 5054.6 5099.3 5124.0 5165.9 5139.0 5164.7 5168.5 5170.0 5202.8 4956.1 4975.4 5019.3 5053.4 5070.3 4720.6 4901.0 4971.8 4982.6 5421.3 5688.5 5801.0 5820.3 5823.6 5824.7 4107.9 4113.7 4117.2 4140.2 4159.2 5649.3 5771.9 5791.7 5796.3 5803.2 5499.3 5574.8 5621.6 5629.3 5639.3 5477.8 5523.5 5555.9 5591.0 5596.6 5251.2 5438.5 5453.9 5490.4 5510.8 5559.8 5567.2 5599.3 5635.2 5682.3 5234.0 5530.7 5532.1 5538.2 5556.7 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - PROCESS | 1732 | [#5] yui.html Cycles:180 Average:14612.70 Median:25186.40 stddev:15972.97 (63.4%) stddev-sans-first:15984.32 20:30:22 INFO - PROCESS | 1732 | Values: 844.5 853.4 870.6 874.8 885.5 14755.3 15265.5 15272.5 15275.8 15277.7 13762.2 14233.9 14248.9 14268.0 14268.7 846.1 851.4 854.6 855.0 859.1 707.3 841.2 854.5 864.2 866.5 898.9 901.5 904.0 905.9 907.6 734.8 900.4 901.1 903.7 903.7 618.2 629.0 631.7 635.7 636.1 14250.1 14329.8 14354.4 14361.6 14396.9 13566.5 13969.4 13991.8 14132.2 14151.3 11993.6 12016.8 12235.1 12273.1 12455.3 4440.4 4527.3 4536.0 4569.6 4640.8 50119.5 50454.7 50657.2 51883.7 52180.5 10512.5 10607.2 10662.7 11006.3 11315.2 18533.2 18936.4 18945.4 19432.5 19917.6 8486.1 8545.7 8556.7 8605.9 8730.6 4918.9 4949.3 5071.6 5167.8 5195.2 3230.6 3313.0 3335.9 3336.0 3336.5 662.5 664.3 667.0 669.7 672.3 632.0 749.2 753.3 784.9 813.0 9117.4 9426.7 9682.2 9759.8 9799.7 739.3 780.7 781.3 791.7 807.9 4505.9 4513.7 4516.2 4589.3 4589.6 48731.0 50065.4 50464.7 50711.7 50778.0 53337.7 53501.2 56010.2 57427.4 57578.0 50238.7 50334.5 50378.2 50503.7 51612.5 8756.1 8893.7 8894.6 8903.6 9094.7 32469.5 32702.7 32803.2 32852.2 33784.8 42134.8 45124.6 45418.1 45783.5 46039.5 11597.8 11852.5 12129.3 12236.3 12279.0 13646.2 13829.9 13967.2 14146.9 14317.9 13001.8 13302.9 13606.8 13657.5 14025.3 13141.3 13286.0 13427.4 13499.7 13747.0 13152.4 13683.2 13710.7 13889.9 13922.2 10978.2 11121.9 11175.5 11295.3 11429.4 11315.5 11502.9 11635.2 11676.1 11795.2 20:30:22 INFO - PROCESS | 1732 | -------- Summary: end -------- 20:30:22 INFO - PROCESS | 1732 | 20:30:22 INFO - TEST-INFO | 1732: exit 0 20:30:22 INFO - TEST-OK | dromaeo_css | took 1112627ms 20:30:22 INFO - TEST-START | kraken 20:30:22 INFO - operating with platform_type : linux_ 20:30:22 INFO - Initialising browser for kraken test... 20:30:22 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeh8ao/profile http://localhost:53805/getInfo.html) 20:30:26 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 20:30:26 INFO - PROCESS | 1918 | colorDepth:24 20:30:26 INFO - PROCESS | 1918 | Browser inner width/height: 1024/697 20:30:26 INFO - PROCESS | 1918 | __metrics 20:30:27 ERROR - PROCESS | 1918 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:30:28 INFO - TEST-INFO | 1918: exit 0 20:30:28 INFO - Browser initialized. 20:30:28 INFO - Running cycle 1/1 for kraken test... 20:30:28 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeh8ao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:39 INFO - PROCESS | 2000 | RSS: Main: 152174592 20:30:39 INFO - PROCESS | 2000 | 20:30:42 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53805/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:43 INFO - PROCESS | 2000 | RSS: Main: 208658432 20:30:43 INFO - PROCESS | 2000 | 20:30:46 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53805/tests/kraken/driver.html?testName=audio-dft) 20:30:46 INFO - PROCESS | 2000 | RSS: Main: 197681152 20:30:46 INFO - PROCESS | 2000 | 20:30:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53805/tests/kraken/driver.html?testName=audio-fft) 20:30:50 INFO - PROCESS | 2000 | RSS: Main: 265007104 20:30:50 INFO - PROCESS | 2000 | 20:30:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53805/tests/kraken/driver.html?testName=audio-oscillator) 20:30:53 INFO - PROCESS | 2000 | RSS: Main: 174170112 20:30:53 INFO - PROCESS | 2000 | 20:30:55 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:30:56 INFO - PROCESS | 2000 | RSS: Main: 178679808 20:30:56 INFO - PROCESS | 2000 | 20:30:59 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53805/tests/kraken/driver.html?testName=imaging-darkroom) 20:30:59 INFO - PROCESS | 2000 | RSS: Main: 214355968 20:30:59 INFO - PROCESS | 2000 | 20:31:03 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53805/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:04 INFO - PROCESS | 2000 | RSS: Main: 212213760 20:31:04 INFO - PROCESS | 2000 | 20:31:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53805/tests/kraken/driver.html?testName=json-parse-financial) 20:31:07 INFO - PROCESS | 2000 | RSS: Main: 213164032 20:31:07 INFO - PROCESS | 2000 | 20:31:09 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:09 INFO - PROCESS | 2000 | RSS: Main: 202604544 20:31:09 INFO - PROCESS | 2000 | 20:31:11 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:12 INFO - PROCESS | 2000 | RSS: Main: 205025280 20:31:12 INFO - PROCESS | 2000 | 20:31:14 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:15 INFO - PROCESS | 2000 | RSS: Main: 213565440 20:31:15 INFO - PROCESS | 2000 | 20:31:17 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:18 INFO - PROCESS | 2000 | RSS: Main: 222789632 20:31:18 INFO - PROCESS | 2000 | 20:31:21 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:21 INFO - PROCESS | 2000 | RSS: Main: 218005504 20:31:21 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:53805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53805/tests/kraken/driver.html?testName=ai-astar) 20:31:23 INFO - PROCESS | 2000 | RSS: Main: 263368704 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | __start_tp_report 20:31:23 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 20:31:23 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 20:31:23 INFO - PROCESS | 2000 | |i|pagename|runs| 20:31:23 INFO - PROCESS | 2000 | |0;ai-astar;112;105;111;110;112;110;110;111;109;110 20:31:23 INFO - PROCESS | 2000 | |1;audio-beat-detection;154;125;157;213;125;153;157;127;176;127 20:31:23 INFO - PROCESS | 2000 | |2;audio-dft;161;161;161;163;162;161;160;160;162;161 20:31:23 INFO - PROCESS | 2000 | |3;audio-fft;76;75;75;149;77;78;75;75;146;74 20:31:23 INFO - PROCESS | 2000 | |4;audio-oscillator;92;92;146;92;91;91;140;92;92;127 20:31:23 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;117;117;117;116;118;116;117;117;116;116 20:31:23 INFO - PROCESS | 2000 | |6;imaging-darkroom;146;145;145;145;146;145;147;145;145;145 20:31:23 INFO - PROCESS | 2000 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 20:31:23 INFO - PROCESS | 2000 | |8;json-parse-financial;59;60;59;58;59;60;60;110;56;57 20:31:23 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;60;60;59;60;60;59;59;59;59;59 20:31:23 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;80;78;84;79;82;79;78;81;85;80 20:31:23 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;134;124;127;138;132;125;124;134;198;127 20:31:23 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;168;165;166;164;171;170;167;170;166;173 20:31:23 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;67;70;65;65;64;69;65;62;63;64 20:31:23 INFO - PROCESS | 2000 | __end_tp_report 20:31:23 INFO - PROCESS | 2000 | __start_cc_report 20:31:23 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1819 20:31:23 INFO - PROCESS | 2000 | __end_cc_report 20:31:23 INFO - PROCESS | 2000 | __startTimestamp1462937483863__endTimestamp 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | ------- Summary: start ------- 20:31:23 INFO - PROCESS | 2000 | Number of tests: 14 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:1.99 20:31:23 INFO - PROCESS | 2000 | Values: 112.0 105.0 111.0 110.0 112.0 110.0 110.0 111.0 109.0 110.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:28.00 (18.0%) stddev-sans-first:29.68 20:31:23 INFO - PROCESS | 2000 | Values: 154.0 125.0 157.0 213.0 125.0 153.0 157.0 127.0 176.0 127.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 20:31:23 INFO - PROCESS | 2000 | Values: 161.0 161.0 161.0 163.0 162.0 161.0 160.0 160.0 162.0 161.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:90.00 Median:75.00 stddev:30.34 (40.4%) stddev-sans-first:31.75 20:31:23 INFO - PROCESS | 2000 | Values: 76.0 75.0 75.0 149.0 77.0 78.0 75.0 75.0 146.0 74.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.00 stddev:22.67 (24.6%) stddev-sans-first:23.51 20:31:23 INFO - PROCESS | 2000 | Values: 92.0 92.0 146.0 92.0 91.0 91.0 140.0 92.0 92.0 127.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:31:23 INFO - PROCESS | 2000 | Values: 117.0 117.0 117.0 116.0 118.0 116.0 117.0 117.0 116.0 116.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:31:23 INFO - PROCESS | 2000 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:31:23 INFO - PROCESS | 2000 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:59.00 stddev:16.29 (27.6%) stddev-sans-first:17.18 20:31:23 INFO - PROCESS | 2000 | Values: 59.0 60.0 59.0 58.0 59.0 60.0 60.0 110.0 56.0 57.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 20:31:23 INFO - PROCESS | 2000 | Values: 60.0 60.0 59.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:2.41 (3.0%) stddev-sans-first:2.55 20:31:23 INFO - PROCESS | 2000 | Values: 80.0 78.0 84.0 79.0 82.0 79.0 78.0 81.0 85.0 80.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:133.00 stddev:22.22 (16.7%) stddev-sans-first:23.55 20:31:23 INFO - PROCESS | 2000 | Values: 134.0 124.0 127.0 138.0 132.0 125.0 124.0 134.0 198.0 127.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:2.91 (1.7%) stddev-sans-first:3.08 20:31:23 INFO - PROCESS | 2000 | Values: 168.0 165.0 166.0 164.0 171.0 170.0 167.0 170.0 166.0 173.0 20:31:23 INFO - PROCESS | 2000 | 20:31:23 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.55 (3.9%) stddev-sans-first:2.64 20:31:23 INFO - PROCESS | 2000 | Values: 67.0 70.0 65.0 65.0 64.0 69.0 65.0 62.0 63.0 64.0 20:31:23 INFO - PROCESS | 2000 | -------- Summary: end -------- 20:31:23 INFO - PROCESS | 2000 | 20:31:24 INFO - TEST-INFO | 2000: exit 0 20:31:24 INFO - TEST-OK | kraken | took 62101ms 20:31:24 INFO - SUITE-END | took 1174s 20:31:25 INFO - Completed test suite (00:19:34) 20:31:25 INFO - javascript benchmark 20:31:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.7699922505803, 3103.549985252137, 3125.9843700781494, 3189.394015137124, 3219.9356012879734, 5317.0, 5348.144296912495, 5455.072637651599, 5558.527525160362, 5603.047481928077, 5483.122700367942, 5507.008738427082, 5581.107022876341, 5594.104943209088, 5666.9433305666935, 4910.901781964368, 4966.751662416865, 4980.626453016021, 5002.199648056312, 5116.948830511685, 5019.874503137415, 5074.061298659742, 5078.898422031557, 5110.565601923841, 5111.02890450815, 4912.38595175603, 4934.55588996992, 4944.085344211297, 5013.849584512471, 5063.949360506384, 4939.036887806879, 4994.101061808873, 4997.525235102659, 5013.273075404082, 5062.519060689228, 4978.079055374767, 4989.351384320052, 4995.100881841267, 4999.8000079996755, 5041.294218809369, 5251.947480525184, 5420.7018613976215, 5471.753771080271, 5500.3949565547755, 5560.304961879765, 5929.169916211734, 5942.257217847769, 5974.8506287342725, 5999.76000959961, 6022.217111775485, 5707.172459993278, 5958.851028724273, 5963.433473820023, 6037.728302226366, 6041.093835924603, 5522.66863988162, 5573.331200255955, 5575.303087114111, 5597.6641401516035, 5645.745941432645, 6046.062860256668, 6055.08605329431, 6076.351016360932, 6109.236345456818, 6111.113888486145, 5656.773729050792, 5730.283714535683, 5868.471837534642, 5913.674747888907, 5920.31916329619, 5820.505257053198, 5864.149698293723, 5871.706414679335, 5872.324682661549, 5930.962081635696, 5715.514181294637, 5758.0, 5769.394213607595, 5771.076627739541, 5796.652200867961, 5654.830355089354, 5717.571182161355, 5773.88452230953, 5823.126531020381, 5830.53355731549, 4389.253826849444, 4401.383806267125, 4401.6698747594055, 4436.6672499562665, 4437.023854751949, 3901.9609803902167, 3925.0, 3925.2345792570177, 3943.191645712622, 3946.7039972002217, 5340.519353258225, 5384.6769193848495, 5442.156465747816, 5450.209719590637, 5515.117581187071, 5929.37741537141, 5950.642961422329, 5976.103584462366, 5986.191864098291, 6014.488768454643, 5505.339359276913, 5556.91664625031, 5564.638298510584, 5566.304211973504, 5569.303837020372, 4799.136155491975, 4887.633427492952, 4911.312416261726, 4918.55732984026, 4932.704037757746, 6095.238095238095, 6098.207233059674, 6102.938970610237, 6105.755769769248, 6111.724972376253, 5741.425857414225, 5885.735141918538, 5888.852778680567, 5915.733791979457, 5916.49709774674, 5946.226990491208, 6005.249343832021, 6016.037434010537, 6017.699115044143, 6036.0644100164545, 5710.743016564182, 5723.885522289447, 5724.198612194379, 5729.71351432435, 5731.770729170787, 5735.082386818089, 5847.736851841592, 5850.619709718854, 5856.4143585641095, 5863.677497737494, 5721.7425215866215, 5768.1636162757, 5784.045632470764, 5788.363280039276, 5845.298564172326, 5690.374058853606, 5735.197072409783, 5750.568707347049, 5751.281089863767, 5776.306843178845, 5433.864153396196, 5601.60788744784, 5636.436356364495, 5675.971620142038, 5691.573132015198, 5824.563157763269, 5860.033094539353, 5861.032929566573, 5870.119482077723, 5872.236609240771, 5640.210370548045, 5646.971765141148, 5682.829515114553, 5684.8010319638615, 5697.031504644303], "value": 5404.289750224241, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.399617380706, 613.8311964209843, 640.9935900640992, 647.1619253067278, 659.274797722505, 34535.654643453556, 44021.0, 44987.77506112465, 44988.77505612475, 47827.52172478274, 44009.0, 44219.77890110553, 44538.77730611342, 44571.33143002858, 44669.32996005063, 8756.956215218916, 8924.776880577972, 8926.955365223197, 8936.687215947442, 8937.195652391283, 8758.693445729401, 8791.560421978907, 8885.289176865836, 8887.644494220256, 8892.377533572653, 8787.692430764924, 8839.116088391174, 8920.46477211366, 8926.687565935194, 8940.284777217807, 8831.470111793313, 8837.60230789616, 8851.690190843321, 8875.689350872688, 8876.999999999967, 8699.478031318142, 8768.956155219246, 8845.955770221171, 8852.734417967471, 8864.645414183426, 41213.38179927303, 41596.37605435921, 41603.7919810399, 41635.0, 41679.0, 3518.2084031093054, 3678.70570354371, 3766.0584853786554, 3927.4501569780255, 4301.483821941356, 32994.6700532994, 33040.50439243413, 33266.83366583176, 33394.49908251378, 33632.15919602005, 4320.6327462165755, 4391.674344419033, 4427.645788336958, 4430.556944305576, 4467.709598876095, 290902.0, 291050.0, 294185.5290723554, 296014.0, 297330.0, 56465.71767141138, 62658.0, 63042.0, 63327.36672633307, 63545.68227158927, 56808.43191568114, 58174.709126454094, 58195.0, 58200.4179958195, 58252.70873645604, 14574.41702331916, 14588.197649129188, 14635.634109147357, 14675.77986330206, 14681.559553213421, 11273.323600583992, 11291.096712262999, 11334.149938754626, 11338.376389298668, 11369.09047276216, 19971.301004464774, 20656.690149647766, 20987.79012209889, 21000.474988125417, 21089.367318980454, 7494.737684181027, 7570.470067095361, 7655.272749088827, 7932.56619215839, 8078.394120440873, 985.261054209343, 1122.9157813164045, 1171.039747407118, 1176.0885313881638, 1193.6001439517686, 32957.835210823796, 33264.501032484535, 33289.83355083209, 33290.0, 33852.32295354079, 1165.3975783297965, 1177.8645455772696, 1193.9462724177433, 1194.5580135349976, 1244.539520377466, 17147.914260428868, 17504.737428938577, 17581.0, 17603.64500871052, 17991.190396432194, 441709.0, 611734.0, 620144.0, 622169.0, 860627.0, 59577.70211148917, 59992.0, 60178.69910650419, 60277.09584356238, 60286.39713602896, 1419.4811551639646, 1427.4932398998205, 1435.7487439698011, 1436.3321055709146, 1447.131720967432, 31622.525662115546, 34175.829120854236, 34180.65819341874, 34214.486782698776, 34438.0, 50708.0, 50914.0, 51133.11969123598, 51196.74401627968, 51385.48614513956, 438614.0, 441971.0, 441990.0, 442173.0, 442624.0, 25618.487630246917, 26509.867450662623, 26645.200643980712, 26723.866380667972, 27256.318592034564, 45924.54075459336, 46207.53792462167, 46433.76783116063, 46672.29991550197, 47125.29312060391, 38977.0, 39010.41484377794, 39523.40714889336, 39640.60359396369, 40181.598184017785, 37845.0, 38745.6125438742, 38784.80607596944, 39112.6088739109, 39631.40552891767, 39762.0, 39962.2007559853, 44130.55869441265, 44918.32622510599, 45137.548624513336, 35386.646133538336, 37192.83238259084, 37241.068973275884, 37681.0, 38455.80772096122, 28556.286092847844, 29175.0, 29202.269943251587, 29205.0, 29249.7075029247], "value": 20332.897604400856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.46264610284226, 376.1142509390386, 377.5714563969895, 389.25457748411793, 394.71186034195034, 14737.926310368433, 16784.832151678478, 18586.256549738013, 19712.112954917025, 19743.703844442327, 16598.170091495438, 17678.116094195302, 17846.0, 17876.82123178768, 19751.40745777629, 5596.692181930002, 5674.177244299574, 5741.167530708045, 5775.27809023872, 5777.884442311151, 5550.888982220353, 5607.943920560803, 5695.572832037593, 5715.114157305624, 5726.255586773714, 5568.192612071247, 5610.887782244353, 5652.039153343921, 5654.236678048473, 5655.151727240926, 5701.714914254291, 5703.971480142614, 5709.200711900337, 5711.343195532505, 5715.3141623005295, 4892.755362231874, 4911.189653707134, 4950.059488697172, 5104.872378190538, 5109.897802043938, 22914.54170916589, 23392.76607233923, 23406.64890026651, 23412.0, 23495.647565286534, 2501.7248102708686, 2668.613051107598, 2783.3320003199287, 2881.4813333599946, 2917.2706823294175, 14343.21112338821, 14456.421743130262, 14467.204303763288, 14773.852261477356, 15266.618334541614, 1818.3908390689135, 1958.5886963737632, 1967.980320196794, 2004.3886614582545, 2058.7014882841904, 72687.0, 75872.62063689702, 76267.0, 77055.61472192603, 79860.20139798644, 10762.3542587445, 10921.290116142425, 10969.561217551209, 11106.500207490682, 11232.3260604364, 15479.380824767108, 15586.06483610987, 15617.76573351378, 15636.530904072895, 15660.373585056697, 7636.160022397532, 7695.538267703956, 7910.248526389983, 7985.560794156378, 8026.036875574969, 7273.309035641606, 7347.265273472717, 7400.777976660709, 7518.887216691754, 7521.623918804038, 4743.525647435229, 4773.212419950739, 4792.640551958617, 4820.4456487503685, 4841.225403935354, 1936.4868309897888, 1946.7079938009413, 1974.4372853736616, 1994.1524851937868, 2007.6687346587942, 991.5538007896475, 1068.56188962525, 1110.3670907582762, 1131.1878967878304, 1153.210051114989, 18809.623807523774, 19200.0, 19215.615687686448, 19383.127759250867, 19466.60452478803, 979.9020097990144, 985.0592683986775, 1018.7962407518526, 1044.8611013994782, 1048.486241741541, 10441.381585854204, 10555.84166237507, 10952.726181845359, 10957.945210274058, 11003.284786488852, 455829.72085139365, 458320.0, 470319.0, 484340.0, 484950.0, 92882.0, 95092.52453737687, 97534.51232743933, 97808.0, 98004.50997745109, 1005.8088963096989, 1012.3015119567622, 1028.9125424339015, 1040.5889673579045, 1052.2791887557048, 16741.1629418531, 16839.747403788708, 16956.66086678284, 17287.913560432116, 17846.929184248987, 26556.336091597863, 28317.0, 38112.809435952644, 39675.82734671873, 41406.79296603498, 57160.0, 58490.0, 58499.4150058494, 58537.70731146317, 59584.0, 8387.161283871565, 8624.741257762276, 8681.479111253346, 8833.249173820297, 8861.689840855539, 11556.191066625255, 12692.492300307884, 12775.0, 12876.291803950873, 12898.484060637844, 11128.221024528206, 11224.607138750105, 11417.771644567229, 11484.885151148716, 11553.133514986577, 10692.14462842955, 10879.347239165676, 11148.163887708291, 11272.0, 11409.60066397672, 11292.701339345751, 11569.132315076235, 11622.0, 11700.941495292469, 11727.061835053346, 8458.0, 8488.363372747192, 8630.654773808978, 8668.869966950375, 8698.695545655872, 10581.31221470602, 11129.220954533104, 11220.270682405617, 11549.769004620028, 11660.06719462424], "value": 9194.887182476486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.5398018653846, 1527.5177836016474, 1552.8369521200273, 1581.9999999999993, 1600.8479194476524, 8396.874046889294, 8722.345824063188, 8734.301255899521, 9030.72907812765, 9031.0, 8748.212660860521, 8929.776755581113, 8932.419392739468, 8935.776605584864, 8944.59749311281, 2049.7437820272467, 2203.6694495825595, 2240.451089483075, 2256.1539422716482, 2272.0798076778933, 2260.954780904381, 2262.6266666000092, 2264.298067599041, 2270.6821045053625, 2277.806386457153, 2243.932682019534, 2257.16484900587, 2267.546490701858, 2267.9886600567056, 2272.681824544565, 1946.6106778644257, 2004.9398518044482, 2006.528465810548, 2064.7935206479383, 2177.640689286266, 2198.2416066457045, 2230.4869879927705, 2235.35174799308, 2235.6870038194666, 2241.6189247827747, 8284.25441710249, 8341.165883411672, 8344.541050242235, 8349.03986041601, 8361.874571881426, 5113.744312784346, 5226.738663066832, 5255.421903590602, 5271.920921186185, 5280.102382594968, 3315.784474009182, 3398.2863598644312, 3429.6227414984332, 3436.2096717754807, 3439.4152993991083, 1023.8361862102103, 1034.4052170002203, 1034.4982683398546, 1035.7203555040096, 1036.8652075230248, 12473.812892806614, 12474.937625311906, 12479.251244925334, 12488.12583119182, 12502.874971250261, 4556.2254416748565, 4615.607673347736, 4653.395058642423, 4715.481297057321, 4735.195016847144, 10460.0, 10473.738156545995, 10479.580816767397, 10491.055804977588, 10541.420221887869, 5205.55752761012, 5207.3490813648295, 5209.218617207373, 5210.6873587584105, 5211.895762084813, 4294.570542945743, 4779.593734532604, 4909.993451342466, 4919.114559379274, 4992.650514464025, 3890.319194141014, 3937.5078115235597, 3973.6821054315587, 4009.558948515661, 4040.6363427291685, 1244.5581818454318, 1263.7662032524013, 1275.6236910111538, 1284.088297308921, 1290.393515047926, 1030.5723124903081, 1046.8115739166872, 1049.2550289294686, 1063.5533076108054, 1064.7125276175543, 6033.3966603340195, 6126.387361263927, 6163.260408750979, 6172.753089876354, 6332.398422149889, 439.8966242932908, 445.1853108810868, 446.48654047845235, 449.5212598582499, 458.72018068977894, 3981.6217459341315, 4143.7720925349395, 4160.729552579072, 4225.704200705921, 4305.784710764449, 10455.372677639367, 10475.16198704117, 10811.459427028618, 11039.779204415867, 11058.612948546763, 11030.889691103146, 11058.11535077192, 11152.721181970515, 11154.330740155616, 11219.046381057702, 8129.634166462523, 8262.504249745034, 8350.66597336112, 8356.122607126164, 8451.0, 6045.093236014633, 6277.905831412624, 6287.528435367457, 6469.094326794158, 6494.512911531749, 9612.66355677548, 10233.641822536176, 10329.225308101772, 10356.844647330447, 10463.0, 10157.492125393848, 10583.0, 10731.785364292826, 10745.516451759846, 10750.408727520062, 7090.787276381717, 7511.549307041595, 7740.535567865946, 7761.379089672925, 7807.843843123219, 8729.127087291221, 8771.473711577326, 8793.076726943578, 8902.910970890209, 8903.154200350957, 7633.69465221385, 7743.961280193563, 7835.764927052198, 7982.920170798217, 8064.0, 7616.0860696716745, 7622.123455802432, 7696.345810605937, 7716.691332346643, 7743.4966727162555, 7049.753258635923, 7052.929470705228, 7111.751088711871, 7131.465140114616, 7142.178649455379, 5012.598992080698, 5125.974370128126, 5160.09698302803, 5244.292020577173, 5266.34170728659, 5022.17134172872, 5118.692878427306, 5145.562627176732, 5199.376074871039, 5275.630705850554], "value": 4540.637331322474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.41890084442946, 320.18353199341675, 322.16559111900176, 329.2805220593006, 330.55540298298797, 5213.2701421800975, 5264.605154613405, 5310.468953104688, 5322.494363035516, 5438.293021907151, 5268.262443257938, 5281.815136470224, 5285.365756109262, 5294.814681486148, 5303.973480132604, 4119.155573107506, 4137.1725654869, 4173.457450531434, 4175.519815221242, 4187.476565429321, 4028.5971402859627, 4173.624373806357, 4195.433616461784, 4205.11692544566, 4213.2837417639075, 4128.938065929014, 4155.937660935088, 4161.875143745692, 4166.729162604436, 4180.205760905418, 4154.273002224613, 4163.146554956226, 4168.832726836491, 4178.227027999815, 4183.99999999997, 3737.0380550211084, 3738.831752571141, 3746.4942232798494, 3761.54861416629, 3782.71629627779, 5071.920512589857, 5144.61415393847, 5151.356080489939, 5182.222666600002, 5211.374635043781, 4767.928481072787, 4770.618350531984, 4777.498362671904, 4782.115308667872, 4782.354382158399, 5415.0, 5553.72231388433, 5565.777368905239, 5571.0807716726695, 5581.916271255935, 4089.7137200395982, 4095.344744840841, 4095.9795201024103, 4096.078382363974, 4109.589041095896, 5547.223388725582, 5582.330120385539, 5811.506021988136, 5835.649861008353, 5844.123381492767, 4106.260873042821, 4118.341065429517, 4118.794060296973, 4121.5878412158545, 4125.133721918371, 4151.481064866892, 4184.163167366539, 4189.120284740238, 4192.874213773592, 4195.433616461739, 4498.145352383037, 4589.5639914208095, 4722.598579120813, 4762.4285085789925, 4784.880377990578, 5460.34475862899, 5502.331369285893, 5518.668879867221, 5565.805196818092, 5566.137248726453, 1430.3777856632398, 1445.756649281617, 1448.8478709735537, 1450.2893582144884, 1453.3024148408822, 906.3791302957495, 951.8477043672979, 952.4665288884889, 955.7945041816043, 965.478641533564, 4776.47458779534, 4807.495213002584, 4815.975920120377, 4827.686200397034, 4831.275308703653, 5055.620828437882, 5063.569596584258, 5079.593632509391, 5124.615653825978, 5136.640435169502, 4509.210888094571, 4776.5701086902345, 4780.139574876555, 4803.879903002383, 4829.95170048302, 2684.6644169478814, 2686.3955609987597, 2689.3729293777374, 2692.4749673813417, 2703.9324016899736, 5121.926843893634, 5151.8196863109615, 5153.433122356538, 5163.741812909339, 5172.956682110545, 4861.416630004422, 5054.6134090159685, 5099.311592934906, 5124.0, 5165.9225111623355, 5139.0, 5164.715940623227, 5168.483151684876, 5169.991851588904, 5202.76587553561, 4956.132676781477, 4975.402951645681, 5019.32239147725, 5053.357658760844, 5070.290159377616, 4720.645951553579, 4900.95099049005, 4971.801127954841, 4982.55505903284, 5421.322334708161, 5688.520984543966, 5801.0, 5820.330661973927, 5823.602335439548, 5824.70876456167, 4107.9178416432105, 4113.71204015716, 4117.197146556393, 4140.171965606831, 4159.188958153131, 5649.322081350264, 5771.9134212986, 5791.739371728367, 5796.275465566804, 5803.158542011469, 5499.2576002240785, 5574.777008919597, 5621.606487545832, 5629.324481062299, 5639.2668953035845, 5477.75350109238, 5523.530499907552, 5555.944440555542, 5590.972045139748, 5596.580256480862, 5251.238570407193, 5438.510534051954, 5453.863653408696, 5490.368607610176, 5510.752016159202, 5559.777608895599, 5567.164925261243, 5599.272094627672, 5635.239242702347, 5682.289713785777, 5234.031704134747, 5530.695811730394, 5532.114861622121, 5538.196961440649, 5556.666600004012], "value": 4130.491568519717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.497523973236, 853.3812985585447, 870.618857424943, 874.7681864305956, 885.4642941020684, 14755.336009879555, 15265.465708700198, 15272.541823745278, 15275.77086343703, 15277.694446111085, 13762.24307663078, 14233.857661423383, 14248.857511424883, 14268.0, 14268.71462570748, 846.1284876577135, 851.4423052900329, 854.5599016506504, 854.9615267312986, 859.1322764008335, 707.345705222667, 841.1924552429645, 854.5257382152903, 864.1790299215738, 866.4714524140269, 898.8966268879065, 901.5131828812433, 904.0326850270213, 905.9456432614031, 907.5734404829719, 734.8420089680691, 900.3832374823235, 901.0538934119214, 903.6746771162376, 903.7153296711581, 618.2086928731231, 629.0093103362223, 631.6810010944489, 635.7234602947733, 636.1189752193245, 14250.073745206528, 14329.78505322421, 14354.354054067488, 14361.569152925429, 14396.928015359961, 13566.525171618947, 13969.371378288002, 13991.790123148161, 14132.152070875678, 14151.29243537819, 11993.580224692181, 12016.819747703792, 12235.086536745905, 12273.079519036108, 12455.314957677325, 4440.400545926291, 4527.298268768346, 4536.0, 4569.634429245685, 4640.79116439761, 50119.49880501185, 50454.7477262615, 50657.24014139791, 51883.74058129685, 52180.47819521832, 10512.526936287886, 10607.15142788575, 10662.733431664115, 11006.284591501688, 11315.151363647594, 18533.166007529693, 18936.43190704281, 18945.43163705091, 19432.514187145436, 19917.60164796725, 8486.108958559385, 8545.658173673108, 8556.74329770108, 8605.913940860637, 8730.607122679494, 4918.90162196754, 4949.257611358253, 5071.5689166420525, 5167.819126330561, 5195.220716892496, 3230.6123265208325, 3313.0, 3335.949960750591, 3336.0158753167875, 3336.4828451590042, 662.4733336997099, 664.2560332427615, 667.0494545272967, 669.7019826177402, 672.3022385284673, 631.9715612797435, 749.2245525880687, 753.3348182245629, 784.9489783164076, 812.975610731679, 9117.407368521157, 9426.717198484057, 9682.225421966226, 9759.756006099762, 9799.657012004545, 739.3198257603018, 780.7072347869549, 781.3468317278379, 791.70311133325, 807.9192080791873, 4505.864824055218, 4513.72917624937, 4516.16450956574, 4589.265717485253, 4589.57106392333, 48731.0, 50065.446987939154, 50464.747676262115, 50711.7464412683, 50778.0, 53337.73331133397, 53501.1974820378, 56010.15984760232, 57427.42572574304, 57578.0, 50238.748806256466, 50334.49665503298, 50378.24432633514, 50503.747481262355, 51612.48387516152, 8756.124387561193, 8893.73318800437, 8894.644214231359, 8903.554822258991, 9094.669690248895, 32469.51295730613, 32702.672973269964, 32803.22762882299, 32852.178695532806, 33784.831075845446, 42134.78932605317, 45124.58504979424, 45418.09163816771, 45783.54216457926, 46039.539604603524, 11597.76804463923, 11852.466639001093, 12129.272243665408, 12236.327002014974, 12279.0, 13646.181229126285, 13829.861701382857, 13967.231802250973, 14146.92926535402, 14317.856821431653, 13001.804972925225, 13302.866971330162, 13606.795898061735, 13657.453701851815, 14025.29873506341, 13141.34293285351, 13286.0, 13427.395767190304, 13499.662508437368, 13747.037707360789, 13152.408141633457, 13683.179009259078, 13710.725785484434, 13889.861101388857, 13922.234277114856, 10978.176636752116, 11121.944390277997, 11175.49710263024, 11295.265807722471, 11429.371384573928, 11315.547378104784, 11502.942485287855, 11635.185537012328, 11676.124290678063, 11795.174337796272], "value": 6932.629517589186, "unit": "score"}], "name": "dromaeo_css", "value": 7130.028958042463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 112.0, 110.0, 110.0, 111.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 157.0, 213.0, 125.0, 153.0, 157.0, 127.0, 176.0, 127.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 160.0, 160.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 149.0, 77.0, 78.0, 75.0, 75.0, 146.0, 74.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 92.0, 91.0, 91.0, 140.0, 92.0, 92.0, 127.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 60.0, 60.0, 110.0, 56.0, 57.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 84.0, 79.0, 82.0, 79.0, 78.0, 81.0, 85.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 127.0, 138.0, 132.0, 125.0, 124.0, 134.0, 198.0, 127.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 166.0, 164.0, 171.0, 170.0, 167.0, 170.0, 166.0, 173.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 65.0, 65.0, 64.0, 69.0, 65.0, 62.0, 63.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1548.6, "alertThreshold": 2.0}]} 20:31:25 INFO - Return code: 0 20:31:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:31:25 ERROR - # TBPL SUCCESS # 20:31:25 INFO - Running post-action listener: _resource_record_post_action 20:31:25 INFO - ##### 20:31:25 INFO - ##### Finished run-tests step (success) 20:31:25 INFO - ##### 20:31:25 INFO - Running post-run listener: _resource_record_post_run 20:31:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536276992; Read time: 12; Write time: 436552 20:31:26 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244891648; Read time: 0; Write time: 286688 20:31:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291385344; Read time: 12; Write time: 149864 20:31:26 INFO - Running post-run listener: _upload_blobber_files 20:31:26 INFO - Blob upload gear active. 20:31:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:26 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 20:31:26 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:26 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:27 INFO - (blobuploader) - INFO - Done attempting. 20:31:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:31:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:28 INFO - (blobuploader) - INFO - Done attempting. 20:31:28 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:28 INFO - Return code: 0 20:31:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c730f94d189f22376df3448809e0cf8826ae7cda100aa20614f3836bf177106ff6e3a72d5c7c917a7a41181a6b864a106f2f5f9ed21dfab40cc10597445ba52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb954c0c78ca4d1e2a9127386ae0f918aad022e774d498bcd6d6de50bec41aba06e1f74e8bf7841da69904c07050343d12d09f3a560e9a229f935faebbcb16d8"} 20:31:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:28 INFO - Contents: 20:31:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c730f94d189f22376df3448809e0cf8826ae7cda100aa20614f3836bf177106ff6e3a72d5c7c917a7a41181a6b864a106f2f5f9ed21dfab40cc10597445ba52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb954c0c78ca4d1e2a9127386ae0f918aad022e774d498bcd6d6de50bec41aba06e1f74e8bf7841da69904c07050343d12d09f3a560e9a229f935faebbcb16d8"} 20:31:28 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:28 INFO - Copying logs to upload dir... 20:31:28 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.791560 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-10 20:31:27.584204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:27.588175) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 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/sha512/2c730f94d189f22376df3448809e0cf8826ae7cda100aa20614f3836bf177106ff6e3a72d5c7c917a7a41181a6b864a106f2f5f9ed21dfab40cc10597445ba52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb954c0c78ca4d1e2a9127386ae0f918aad022e774d498bcd6d6de50bec41aba06e1f74e8bf7841da69904c07050343d12d09f3a560e9a229f935faebbcb16d8"} build_url:https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/f_38WHqwQeaGNcb3MY0cOA/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/sha512/2c730f94d189f22376df3448809e0cf8826ae7cda100aa20614f3836bf177106ff6e3a72d5c7c917a7a41181a6b864a106f2f5f9ed21dfab40cc10597445ba52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb954c0c78ca4d1e2a9127386ae0f918aad022e774d498bcd6d6de50bec41aba06e1f74e8bf7841da69904c07050343d12d09f3a560e9a229f935faebbcb16d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:27.612608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:27.612943) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462934817.370749-2071939145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 20:31:27.695648) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:31:27.695978) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 20:31:27.696314) ========= ========= Total master_lag: 0.16 =========