builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1466682452.93 results: success (0) buildid: 20160623035624 builduid: 59198177c1bb4eb08d4eb98d356987bc revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:32.934819) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:32.935851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:32.936485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:32.952869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:32.953223) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:47:33-- 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% 31.4M=0s 2016-06-23 04:47:33 (31.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.043960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.044306) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.094060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.094421) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:47:33,293 truncating revision to first 12 chars 2016-06-23 04:47:33,293 Setting DEBUG logging. 2016-06-23 04:47:33,293 attempt 1/10 2016-06-23 04:47:33,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:47:33,614 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.803863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.804244) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.804697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.805001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:47:33.814451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-23 04:47:33.814755) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:47:34 INFO - MultiFileLogger online at 20160623 04:47:34 in /builds/slave/test 04:47:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:47:34 INFO - {'append_to_log': False, 04:47:34 INFO - 'base_work_dir': '/builds/slave/test', 04:47:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:47:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:47:34 INFO - 'config_files': ('talos/linux_config.py',), 04:47:34 INFO - 'default_actions': ('clobber', 04:47:34 INFO - 'read-buildbot-config', 04:47:34 INFO - 'download-and-extract', 04:47:34 INFO - 'populate-webroot', 04:47:34 INFO - 'create-virtualenv', 04:47:34 INFO - 'install', 04:47:34 INFO - 'run-tests'), 04:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:47:34 INFO - 'download_minidump_stackwalk': True, 04:47:34 INFO - 'download_symbols': 'ondemand', 04:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:47:34 INFO - 'installer_path': 'installer.exe', 04:47:34 INFO - 'log_level': 'info', 04:47:34 INFO - 'log_name': 'talos', 04:47:34 INFO - 'log_to_console': True, 04:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:47:34 INFO - 'opt_config_files': (), 04:47:34 INFO - 'pip_index': False, 04:47:34 INFO - 'sps_profile': False, 04:47:34 INFO - 'sps_profile_interval': 0, 04:47:34 INFO - 'suite': 'dromaeojs-e10s', 04:47:34 INFO - 'system_bits': '32', 04:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:47:34 INFO - 'title': 'talos-linux64-ix-047', 04:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:47:34 INFO - 'use_talos_json': True, 04:47:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:47:34 INFO - 'work_dir': 'build'} 04:47:34 INFO - ##### 04:47:34 INFO - ##### Running clobber step. 04:47:34 INFO - ##### 04:47:34 INFO - Running pre-action listener: _resource_record_pre_action 04:47:34 INFO - Running main action method: clobber 04:47:34 INFO - rmtree: /builds/slave/test/build 04:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:47:35 INFO - Running post-action listener: _resource_record_post_action 04:47:35 INFO - ##### 04:47:35 INFO - ##### Finished clobber step (success) 04:47:35 INFO - ##### 04:47:35 INFO - ##### 04:47:35 INFO - ##### Running read-buildbot-config step. 04:47:35 INFO - ##### 04:47:35 INFO - Running pre-action listener: _resource_record_pre_action 04:47:35 INFO - Running main action method: read_buildbot_config 04:47:35 INFO - Using buildbot properties: 04:47:35 INFO - { 04:47:35 INFO - "project": "", 04:47:35 INFO - "product": "firefox", 04:47:35 INFO - "script_repo_revision": "production", 04:47:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:47:35 INFO - "repository": "", 04:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:47:35 INFO - "buildid": "20160623035624", 04:47:35 INFO - "pgo_build": "False", 04:47:35 INFO - "basedir": "/builds/slave/test", 04:47:35 INFO - "buildnumber": 1605, 04:47:35 INFO - "slavename": "talos-linux64-ix-047", 04:47:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:47:35 INFO - "platform": "ubuntu64_hw", 04:47:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:47:35 INFO - "branch": "fx-team", 04:47:35 INFO - "repo_path": "integration/fx-team", 04:47:35 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 04:47:35 INFO - "stage_platform": "linux64", 04:47:35 INFO - "builduid": "59198177c1bb4eb08d4eb98d356987bc", 04:47:35 INFO - "slavebuilddir": "test" 04:47:35 INFO - } 04:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:47:35 INFO - Running post-action listener: _resource_record_post_action 04:47:35 INFO - ##### 04:47:35 INFO - ##### Finished read-buildbot-config step (success) 04:47:35 INFO - ##### 04:47:35 INFO - ##### 04:47:35 INFO - ##### Running download-and-extract step. 04:47:35 INFO - ##### 04:47:35 INFO - Running pre-action listener: _resource_record_pre_action 04:47:35 INFO - Running main action method: download_and_extract 04:47:35 INFO - mkdir: /builds/slave/test/build/tests 04:47:35 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')]} 04:47:35 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:47:35 INFO - Downloaded 1361 bytes. 04:47:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:47:35 INFO - Using the following test package requirements: 04:47:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:47:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:47:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:47:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'jsshell-linux-x86_64.zip'], 04:47:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:47:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:47:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:47:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:47:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:47:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:47:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:47:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:47:35 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')]} 04:47:35 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:47:36 INFO - Downloaded 22709579 bytes. 04:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:47:38 INFO - Return code: 0 04:47:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:38 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:47:40 INFO - Downloaded 22709579 bytes. 04:47:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:47:41 INFO - Return code: 0 04:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:41 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:47:42 INFO - Downloaded 14405384 bytes. 04:47:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:47:42 INFO - Return code: 0 04:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:42 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:47:44 INFO - Downloaded 56247220 bytes. 04:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:47:44 INFO - mkdir: /builds/slave/test/properties 04:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:44 INFO - Contents: 04:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:47:44 INFO - Running post-action listener: _resource_record_post_action 04:47:44 INFO - Running post-action listener: set_extra_try_arguments 04:47:44 INFO - ##### 04:47:44 INFO - ##### Finished download-and-extract step (success) 04:47:44 INFO - ##### 04:47:44 INFO - ##### 04:47:44 INFO - ##### Running populate-webroot step. 04:47:44 INFO - ##### 04:47:44 INFO - Running pre-action listener: _resource_record_pre_action 04:47:44 INFO - Running main action method: populate_webroot 04:47:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:44 INFO - '--tppagecycles', 04:47:44 INFO - '7'], 04:47:44 INFO - 'tests': ['tsvgm']}}, 04:47:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['damp', 'tps']}, 04:47:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'tests': ['damp', 'tps']}, 04:47:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['dromaeo_dom']}, 04:47:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['basic_compositor_video']}, 04:47:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['a11yr', 04:47:44 INFO - 'ts_paint', 04:47:44 INFO - 'tpaint', 04:47:44 INFO - 'sessionrestore', 04:47:44 INFO - 'sessionrestore_no_auto_restore', 04:47:44 INFO - 'tabpaint']}, 04:47:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['tsvgx', 04:47:44 INFO - 'tsvgr_opacity', 04:47:44 INFO - 'tart', 04:47:44 INFO - 'tscrollx', 04:47:44 INFO - 'cart']}, 04:47:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:44 INFO - 'tsvgr_opacity', 04:47:44 INFO - 'tart', 04:47:44 INFO - 'tscrollx', 04:47:44 INFO - 'cart']}, 04:47:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'talos_options': ['--disable-e10s'], 04:47:44 INFO - 'tests': ['tp5o']}, 04:47:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'tests': ['tp5o']}, 04:47:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'talos_options': ['--disable-e10s', 04:47:44 INFO - '--xperf_path', 04:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:44 INFO - 'tests': ['tp5n']}, 04:47:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:44 INFO - 'talos_options': ['--xperf_path', 04:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:44 INFO - 'tests': ['tp5n']}}, 04:47:44 INFO - 'talos.zip': {'path': '', 04:47:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:44 INFO - Running post-action listener: _resource_record_post_action 04:47:44 INFO - ##### 04:47:44 INFO - ##### Finished populate-webroot step (success) 04:47:44 INFO - ##### 04:47:44 INFO - ##### 04:47:44 INFO - ##### Running create-virtualenv step. 04:47:44 INFO - ##### 04:47:44 INFO - Running pre-action listener: _resource_record_pre_action 04:47:44 INFO - Running main action method: create_virtualenv 04:47:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:44 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 04:47:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:45 INFO - Using real prefix '/usr' 04:47:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:47 INFO - Installing pip.................done. 04:47:47 INFO - Return code: 0 04:47:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:47 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')]} 04:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:47 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')]} 04:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:47 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:47 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 04:47:47 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 04:47:47 INFO - Using env: {'DISPLAY': ':0', 04:47:47 INFO - 'HOME': '/home/cltbld', 04:47:47 INFO - 'LANG': 'en_US.UTF-8', 04:47:47 INFO - 'LANGUAGE': 'en_US:en', 04:47:47 INFO - 'LOGNAME': 'cltbld', 04:47:47 INFO - 'MAIL': '/var/mail/cltbld', 04:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:47 INFO - 'MOZ_NO_REMOTE': '1', 04:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:47 INFO - 'NO_EM_RESTART': '1', 04:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:47 INFO - 'PWD': '/builds/slave/test', 04:47:47 INFO - 'SHELL': '/bin/bash', 04:47:47 INFO - 'SHLVL': '1', 04:47:47 INFO - 'TERM': 'linux', 04:47:47 INFO - 'TMOUT': '86400', 04:47:47 INFO - 'USER': 'cltbld', 04:47:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:47 INFO - '_': '/tools/buildbot/bin/python'} 04:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:47 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 04:47:47 INFO - Cleaning up... 04:47:47 INFO - Return code: 0 04:47:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:47 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')]} 04:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:47 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')]} 04:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:47 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:47 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>=3.1.1'] in /builds/slave/test/build 04:47:47 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>=3.1.1 04:47:47 INFO - Using env: {'DISPLAY': ':0', 04:47:47 INFO - 'HOME': '/home/cltbld', 04:47:47 INFO - 'LANG': 'en_US.UTF-8', 04:47:47 INFO - 'LANGUAGE': 'en_US:en', 04:47:47 INFO - 'LOGNAME': 'cltbld', 04:47:47 INFO - 'MAIL': '/var/mail/cltbld', 04:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:47 INFO - 'MOZ_NO_REMOTE': '1', 04:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:47 INFO - 'NO_EM_RESTART': '1', 04:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:47 INFO - 'PWD': '/builds/slave/test', 04:47:47 INFO - 'SHELL': '/bin/bash', 04:47:47 INFO - 'SHLVL': '1', 04:47:47 INFO - 'TERM': 'linux', 04:47:47 INFO - 'TMOUT': '86400', 04:47:47 INFO - 'USER': 'cltbld', 04:47:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:47 INFO - '_': '/tools/buildbot/bin/python'} 04:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:47 INFO - Downloading/unpacking psutil>=3.1.1 04:47:47 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 04:47:47 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 04:47:47 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 04:47:47 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 04:47:47 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 04:47:47 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 04:47:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:49 INFO - Installing collected packages: psutil 04:47:49 INFO - Running setup.py install for psutil 04:47:50 INFO - building 'psutil._psutil_linux' extension 04:47:50 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 04:47:50 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 04:47:50 INFO - building 'psutil._psutil_posix' extension 04:47:50 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 04:47:50 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 04:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:50 INFO - Successfully installed psutil 04:47:50 INFO - Cleaning up... 04:47:50 INFO - Return code: 0 04:47:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:50 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:50 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.3'] in /builds/slave/test/build 04:47:50 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.3 04:47:50 INFO - Using env: {'DISPLAY': ':0', 04:47:50 INFO - 'HOME': '/home/cltbld', 04:47:50 INFO - 'LANG': 'en_US.UTF-8', 04:47:50 INFO - 'LANGUAGE': 'en_US:en', 04:47:50 INFO - 'LOGNAME': 'cltbld', 04:47:50 INFO - 'MAIL': '/var/mail/cltbld', 04:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:50 INFO - 'MOZ_NO_REMOTE': '1', 04:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:50 INFO - 'NO_EM_RESTART': '1', 04:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:50 INFO - 'PWD': '/builds/slave/test', 04:47:50 INFO - 'SHELL': '/bin/bash', 04:47:50 INFO - 'SHLVL': '1', 04:47:50 INFO - 'TERM': 'linux', 04:47:50 INFO - 'TMOUT': '86400', 04:47:50 INFO - 'USER': 'cltbld', 04:47:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:50 INFO - '_': '/tools/buildbot/bin/python'} 04:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:50 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 04:47:50 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 04:47:50 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 04:47:50 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 04:47:50 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 04:47:50 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 04:47:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:52 INFO - Installing collected packages: mozsystemmonitor 04:47:52 INFO - Running setup.py install for mozsystemmonitor 04:47:52 INFO - Successfully installed mozsystemmonitor 04:47:52 INFO - Cleaning up... 04:47:52 INFO - Return code: 0 04:47:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:52 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')]} 04:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:52 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')]} 04:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:52 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:52 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==2.5.1'] in /builds/slave/test/build 04:47:52 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==2.5.1 04:47:52 INFO - Using env: {'DISPLAY': ':0', 04:47:52 INFO - 'HOME': '/home/cltbld', 04:47:52 INFO - 'LANG': 'en_US.UTF-8', 04:47:52 INFO - 'LANGUAGE': 'en_US:en', 04:47:52 INFO - 'LOGNAME': 'cltbld', 04:47:52 INFO - 'MAIL': '/var/mail/cltbld', 04:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:52 INFO - 'MOZ_NO_REMOTE': '1', 04:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:52 INFO - 'NO_EM_RESTART': '1', 04:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:52 INFO - 'PWD': '/builds/slave/test', 04:47:52 INFO - 'SHELL': '/bin/bash', 04:47:52 INFO - 'SHLVL': '1', 04:47:52 INFO - 'TERM': 'linux', 04:47:52 INFO - 'TMOUT': '86400', 04:47:52 INFO - 'USER': 'cltbld', 04:47:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:52 INFO - '_': '/tools/buildbot/bin/python'} 04:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:53 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 04:47:53 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 04:47:53 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 04:47:53 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 04:47:53 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 04:47:53 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 04:47:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:54 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 04:47:54 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 04:47:54 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 04:47:54 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 04:47:54 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 04:47:54 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 04:47:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:55 INFO - warning: no files found matching '*.txt' 04:47:55 INFO - no previously-included directories found matching 'build' 04:47:55 INFO - no previously-included directories found matching 'dist' 04:47:55 INFO - no previously-included directories found matching '.git*' 04:47:55 INFO - Installing collected packages: jsonschema, functools32 04:47:55 INFO - Running setup.py install for functools32 04:47:55 INFO - warning: no files found matching '*.txt' 04:47:55 INFO - no previously-included directories found matching 'build' 04:47:55 INFO - no previously-included directories found matching 'dist' 04:47:55 INFO - no previously-included directories found matching '.git*' 04:47:55 INFO - Successfully installed jsonschema functools32 04:47:55 INFO - Cleaning up... 04:47:55 INFO - Return code: 0 04:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:55 INFO - Using env: {'DISPLAY': ':0', 04:47:55 INFO - 'HOME': '/home/cltbld', 04:47:55 INFO - 'LANG': 'en_US.UTF-8', 04:47:55 INFO - 'LANGUAGE': 'en_US:en', 04:47:55 INFO - 'LOGNAME': 'cltbld', 04:47:55 INFO - 'MAIL': '/var/mail/cltbld', 04:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:55 INFO - 'MOZ_NO_REMOTE': '1', 04:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:55 INFO - 'NO_EM_RESTART': '1', 04:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:55 INFO - 'PWD': '/builds/slave/test', 04:47:55 INFO - 'SHELL': '/bin/bash', 04:47:55 INFO - 'SHLVL': '1', 04:47:55 INFO - 'TERM': 'linux', 04:47:55 INFO - 'TMOUT': '86400', 04:47:55 INFO - 'USER': 'cltbld', 04:47:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:55 INFO - '_': '/tools/buildbot/bin/python'} 04:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:57 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 04:47:57 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 04:47:57 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 04:47:57 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 04:47:57 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 04:47:57 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 04:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:58 INFO - Downloading docopt-0.6.1.tar.gz 04:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:58 INFO - Running setup.py install for blobuploader 04:47:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:58 INFO - Running setup.py install for requests 04:47:58 INFO - Running setup.py install for docopt 04:47:58 INFO - Successfully installed blobuploader requests docopt 04:47:58 INFO - Cleaning up... 04:47:58 INFO - Return code: 0 04:47:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:58 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')]} 04:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:58 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')]} 04:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:58 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:47:58 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 04:47:58 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 04:47:58 INFO - Using env: {'DISPLAY': ':0', 04:47:58 INFO - 'HOME': '/home/cltbld', 04:47:58 INFO - 'LANG': 'en_US.UTF-8', 04:47:58 INFO - 'LANGUAGE': 'en_US:en', 04:47:58 INFO - 'LOGNAME': 'cltbld', 04:47:58 INFO - 'MAIL': '/var/mail/cltbld', 04:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:58 INFO - 'MOZ_NO_REMOTE': '1', 04:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:58 INFO - 'NO_EM_RESTART': '1', 04:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:58 INFO - 'PWD': '/builds/slave/test', 04:47:58 INFO - 'SHELL': '/bin/bash', 04:47:58 INFO - 'SHLVL': '1', 04:47:58 INFO - 'TERM': 'linux', 04:47:58 INFO - 'TMOUT': '86400', 04:47:58 INFO - 'USER': 'cltbld', 04:47:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:58 INFO - '_': '/tools/buildbot/bin/python'} 04:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:59 INFO - Running setup.py (path:/tmp/pip-jWHhoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:59 INFO - Running setup.py (path:/tmp/pip-2CZNPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:59 INFO - Running setup.py (path:/tmp/pip-HuQfDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:59 INFO - Running setup.py (path:/tmp/pip-qkvjhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:59 INFO - Running setup.py (path:/tmp/pip-MdFWB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:59 INFO - Running setup.py (path:/tmp/pip-I9TcMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:59 INFO - Running setup.py (path:/tmp/pip-DEH8Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:59 INFO - Running setup.py (path:/tmp/pip-uC7CQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:59 INFO - Running setup.py (path:/tmp/pip-uqWRnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:59 INFO - Running setup.py (path:/tmp/pip-hF1ckn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:59 INFO - Running setup.py (path:/tmp/pip-3RJMBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:59 INFO - Running setup.py (path:/tmp/pip-gh3kvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:59 INFO - Running setup.py (path:/tmp/pip-XKBj5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:00 INFO - Running setup.py (path:/tmp/pip-ZmuiP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:00 INFO - Running setup.py (path:/tmp/pip-vhYGps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:00 INFO - Running setup.py (path:/tmp/pip-MhZAji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:00 INFO - Running setup.py (path:/tmp/pip-HDyBJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:00 INFO - Running setup.py install for manifestparser 04:48:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:00 INFO - Running setup.py install for mozcrash 04:48:00 INFO - Running setup.py install for mozdebug 04:48:00 INFO - Running setup.py install for mozdevice 04:48:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:48:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:00 INFO - Running setup.py install for mozfile 04:48:00 INFO - Running setup.py install for mozhttpd 04:48:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:00 INFO - Running setup.py install for mozinfo 04:48:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for mozInstall 04:48:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for mozleak 04:48:01 INFO - Running setup.py install for mozlog 04:48:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for moznetwork 04:48:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for mozprocess 04:48:01 INFO - Running setup.py install for mozprofile 04:48:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for mozrunner 04:48:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:01 INFO - Running setup.py install for mozscreenshot 04:48:01 INFO - Running setup.py install for moztest 04:48:01 INFO - Running setup.py install for mozversion 04:48:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:02 INFO - Cleaning up... 04:48:02 INFO - Return code: 0 04:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:02 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:48:02 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 04:48:02 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 04:48:02 INFO - Using env: {'DISPLAY': ':0', 04:48:02 INFO - 'HOME': '/home/cltbld', 04:48:02 INFO - 'LANG': 'en_US.UTF-8', 04:48:02 INFO - 'LANGUAGE': 'en_US:en', 04:48:02 INFO - 'LOGNAME': 'cltbld', 04:48:02 INFO - 'MAIL': '/var/mail/cltbld', 04:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:02 INFO - 'MOZ_NO_REMOTE': '1', 04:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:02 INFO - 'NO_EM_RESTART': '1', 04:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:02 INFO - 'PWD': '/builds/slave/test', 04:48:02 INFO - 'SHELL': '/bin/bash', 04:48:02 INFO - 'SHLVL': '1', 04:48:02 INFO - 'TERM': 'linux', 04:48:02 INFO - 'TMOUT': '86400', 04:48:02 INFO - 'USER': 'cltbld', 04:48:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:02 INFO - '_': '/tools/buildbot/bin/python'} 04:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:02 INFO - Running setup.py (path:/tmp/pip-1_aEWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:02 INFO - Running setup.py (path:/tmp/pip-_35IzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:02 INFO - Running setup.py (path:/tmp/pip-kNzBey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:02 INFO - Running setup.py (path:/tmp/pip-CQuX3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:02 INFO - Running setup.py (path:/tmp/pip-_8xUab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:02 INFO - Running setup.py (path:/tmp/pip-NKrsQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:02 INFO - Running setup.py (path:/tmp/pip-nBfz9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:02 INFO - Running setup.py (path:/tmp/pip-j6IEqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:02 INFO - Running setup.py (path:/tmp/pip-8mMCCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:02 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)) 04:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:02 INFO - Running setup.py (path:/tmp/pip-JFZ9M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:03 INFO - Running setup.py (path:/tmp/pip-fm1aOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:03 INFO - Running setup.py (path:/tmp/pip-HSHV0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:03 INFO - Running setup.py (path:/tmp/pip-Y7BMkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:03 INFO - Running setup.py (path:/tmp/pip-K4ib5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:03 INFO - Running setup.py (path:/tmp/pip-euLts3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:03 INFO - Running setup.py (path:/tmp/pip-iQ2_pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:03 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)) 04:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:03 INFO - Running setup.py (path:/tmp/pip-A0zJQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:03 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)) 04:48:03 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)) 04:48:03 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)) 04:48:03 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)) 04:48:03 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)) 04:48:03 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)) 04:48:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:03 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 04:48:03 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 04:48:03 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 04:48:03 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 04:48:03 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 04:48:03 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 04:48:05 INFO - Downloading blessings-1.6.tar.gz 04:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:05 INFO - Installing collected packages: blessings 04:48:05 INFO - Running setup.py install for blessings 04:48:05 INFO - Successfully installed blessings 04:48:05 INFO - Cleaning up... 04:48:05 INFO - Return code: 0 04:48:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:05 INFO - Reading from file tmpfile_stdout 04:48:05 INFO - Current package versions: 04:48:05 INFO - argparse == 1.2.1 04:48:05 INFO - blessings == 1.6 04:48:05 INFO - blobuploader == 1.2.4 04:48:05 INFO - docopt == 0.6.1 04:48:05 INFO - functools32 == 3.2.3-2 04:48:05 INFO - jsonschema == 2.5.1 04:48:05 INFO - manifestparser == 1.1 04:48:05 INFO - mozInstall == 1.12 04:48:05 INFO - mozcrash == 0.17 04:48:05 INFO - mozdebug == 0.1 04:48:05 INFO - mozdevice == 0.48 04:48:05 INFO - mozfile == 1.2 04:48:05 INFO - mozhttpd == 0.7 04:48:05 INFO - mozinfo == 0.9 04:48:05 INFO - mozleak == 0.1 04:48:05 INFO - mozlog == 3.2 04:48:05 INFO - moznetwork == 0.27 04:48:05 INFO - mozprocess == 0.22 04:48:05 INFO - mozprofile == 0.28 04:48:05 INFO - mozrunner == 6.11 04:48:05 INFO - mozscreenshot == 0.1 04:48:05 INFO - mozsystemmonitor == 0.3 04:48:05 INFO - moztest == 0.7 04:48:05 INFO - mozversion == 1.4 04:48:05 INFO - psutil == 3.1.1 04:48:05 INFO - requests == 1.2.3 04:48:05 INFO - wsgiref == 0.1.2 04:48:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:05 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:48:05 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 04:48:05 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 04:48:05 INFO - Using env: {'DISPLAY': ':0', 04:48:05 INFO - 'HOME': '/home/cltbld', 04:48:05 INFO - 'LANG': 'en_US.UTF-8', 04:48:05 INFO - 'LANGUAGE': 'en_US:en', 04:48:05 INFO - 'LOGNAME': 'cltbld', 04:48:05 INFO - 'MAIL': '/var/mail/cltbld', 04:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:05 INFO - 'MOZ_NO_REMOTE': '1', 04:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:05 INFO - 'NO_EM_RESTART': '1', 04:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:05 INFO - 'PWD': '/builds/slave/test', 04:48:05 INFO - 'SHELL': '/bin/bash', 04:48:05 INFO - 'SHLVL': '1', 04:48:05 INFO - 'TERM': 'linux', 04:48:05 INFO - 'TMOUT': '86400', 04:48:05 INFO - 'USER': 'cltbld', 04:48:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:05 INFO - '_': '/tools/buildbot/bin/python'} 04:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 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)) 04:48:06 INFO - Cleaning up... 04:48:06 INFO - Return code: 0 04:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:48:06 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 04:48:06 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 04:48:06 INFO - Using env: {'DISPLAY': ':0', 04:48:06 INFO - 'HOME': '/home/cltbld', 04:48:06 INFO - 'LANG': 'en_US.UTF-8', 04:48:06 INFO - 'LANGUAGE': 'en_US:en', 04:48:06 INFO - 'LOGNAME': 'cltbld', 04:48:06 INFO - 'MAIL': '/var/mail/cltbld', 04:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:06 INFO - 'MOZ_NO_REMOTE': '1', 04:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:06 INFO - 'NO_EM_RESTART': '1', 04:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:06 INFO - 'PWD': '/builds/slave/test', 04:48:06 INFO - 'SHELL': '/bin/bash', 04:48:06 INFO - 'SHLVL': '1', 04:48:06 INFO - 'TERM': 'linux', 04:48:06 INFO - 'TMOUT': '86400', 04:48:06 INFO - 'USER': 'cltbld', 04:48:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:06 INFO - '_': '/tools/buildbot/bin/python'} 04:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:48:06 INFO - Cleaning up... 04:48:06 INFO - Return code: 0 04:48:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:06 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 0x7fe688934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', '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 04:48:06 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 04:48:06 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 04:48:06 INFO - Using env: {'DISPLAY': ':0', 04:48:06 INFO - 'HOME': '/home/cltbld', 04:48:06 INFO - 'LANG': 'en_US.UTF-8', 04:48:06 INFO - 'LANGUAGE': 'en_US:en', 04:48:06 INFO - 'LOGNAME': 'cltbld', 04:48:06 INFO - 'MAIL': '/var/mail/cltbld', 04:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:06 INFO - 'MOZ_NO_REMOTE': '1', 04:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:06 INFO - 'NO_EM_RESTART': '1', 04:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:06 INFO - 'PWD': '/builds/slave/test', 04:48:06 INFO - 'SHELL': '/bin/bash', 04:48:06 INFO - 'SHLVL': '1', 04:48:06 INFO - 'TERM': 'linux', 04:48:06 INFO - 'TMOUT': '86400', 04:48:06 INFO - 'USER': 'cltbld', 04:48:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:06 INFO - '_': '/tools/buildbot/bin/python'} 04:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:06 INFO - Downloading/unpacking flake8 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:48:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:48:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:09 INFO - no previously-included directories found matching 'docs/_build' 04:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:48:09 INFO - Running setup.py install for pep8 04:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:09 INFO - no previously-included directories found matching 'docs/_build' 04:48:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:48:09 INFO - Cleaning up... 04:48:09 INFO - Return code: 0 04:48:09 INFO - Running post-action listener: _resource_record_post_action 04:48:09 INFO - Running post-action listener: _start_resource_monitoring 04:48:09 INFO - Starting resource monitoring. 04:48:09 INFO - ##### 04:48:09 INFO - ##### Finished create-virtualenv step (success) 04:48:09 INFO - ##### 04:48:09 INFO - ##### 04:48:09 INFO - ##### Running install step. 04:48:09 INFO - ##### 04:48:09 INFO - Running pre-action listener: _resource_record_pre_action 04:48:09 INFO - Running main action method: install 04:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:09 INFO - Reading from file tmpfile_stdout 04:48:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:09 INFO - Reading from file tmpfile_stdout 04:48:09 INFO - Output received: 04:48:09 INFO - Usage: mozinstall [options] installer 04:48:09 INFO - Options: 04:48:09 INFO - -h, --help show this help message and exit 04:48:09 INFO - -d DEST, --destination=DEST 04:48:09 INFO - Directory to install application into. [default: 04:48:09 INFO - "/builds/slave/test"] 04:48:09 INFO - --app=APP Application being installed. [default: firefox] 04:48:09 INFO - mkdir: /builds/slave/test/build/application 04:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:48:25 INFO - Reading from file tmpfile_stdout 04:48:25 INFO - Output received: 04:48:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:48:25 INFO - Running post-action listener: _resource_record_post_action 04:48:25 INFO - ##### 04:48:25 INFO - ##### Finished install step (success) 04:48:25 INFO - ##### 04:48:25 INFO - ##### 04:48:25 INFO - ##### Running run-tests step. 04:48:25 INFO - ##### 04:48:25 INFO - Running pre-action listener: _resource_record_pre_action 04:48:25 INFO - Running main action method: run_tests 04:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:48:25 INFO - Python 2.7.3 04:48:25 INFO - Return code: 0 04:48:25 INFO - grabbing minidump binary from tooltool 04:48:25 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')]} 04:48:25 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 0x19581c0>, '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 0x19590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:48:25 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 04:48:25 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 04:48:25 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 04:48:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:48:26 INFO - Return code: 0 04:48:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:48:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:48:26 INFO - Return code: 0 04:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:48:26 INFO - Using env: {'DISPLAY': ':0', 04:48:26 INFO - 'HOME': '/home/cltbld', 04:48:26 INFO - 'LANG': 'en_US.UTF-8', 04:48:26 INFO - 'LANGUAGE': 'en_US:en', 04:48:26 INFO - 'LOGNAME': 'cltbld', 04:48:26 INFO - 'MAIL': '/var/mail/cltbld', 04:48:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:48:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:26 INFO - 'MOZ_NO_REMOTE': '1', 04:48:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:26 INFO - 'NO_EM_RESTART': '1', 04:48:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:26 INFO - 'PWD': '/builds/slave/test', 04:48:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:48:26 INFO - 'SHELL': '/bin/bash', 04:48:26 INFO - 'SHLVL': '1', 04:48:26 INFO - 'TERM': 'linux', 04:48:26 INFO - 'TMOUT': '86400', 04:48:26 INFO - 'USER': 'cltbld', 04:48:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297', 04:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:26 INFO - '_': '/tools/buildbot/bin/python'} 04:48:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:48:27 INFO - mozversion application_buildid: 20160623035624 04:48:27 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 04:48:27 INFO - mozversion application_display_name: Nightly 04:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:48:27 INFO - mozversion application_name: Firefox 04:48:27 INFO - mozversion application_remotingname: firefox 04:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:48:27 INFO - mozversion application_vendor: Mozilla 04:48:27 INFO - mozversion application_version: 50.0a1 04:48:27 INFO - mozversion platform_buildid: 20160623035624 04:48:27 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 04:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:48:27 INFO - mozversion platform_version: 50.0a1 04:48:27 INFO - using testdate: 1466682507 04:48:27 INFO - actual date: 1466682507 04:48:27 INFO - starting webserver on 'localhost:42769' 04:48:27 INFO - SUITE-START | Running 2 tests 04:48:27 INFO - TEST-START | dromaeo_css 04:48:27 INFO - operating with platform_type : linux_ 04:48:27 INFO - Initialising browser for dromaeo_css test... 04:48:27 INFO - TEST-INFO | started process 28792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0j5m8f/profile http://localhost:42769/getInfo.html) 04:48:32 INFO - PROCESS | 28792 | __metrics Screen width/height:1600/1200 04:48:32 INFO - PROCESS | 28792 | colorDepth:24 04:48:32 INFO - PROCESS | 28792 | Browser inner width/height: 1024/697 04:48:32 INFO - PROCESS | 28792 | __metrics 04:48:32 ERROR - PROCESS | 28792 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:48:33 INFO - TEST-INFO | 28792: exit 0 04:48:33 INFO - Browser initialized. 04:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:33 INFO - TEST-INFO | started process 28912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0j5m8f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:46 INFO - PROCESS | 28912 | RSS: Main: 186445824 04:48:46 INFO - PROCESS | 28912 | 04:49:35 INFO - PROCESS | 28912 | 1466682575678 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] 04:51:48 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42769/tests/dromaeo/cssquery-ext.html) 04:51:49 INFO - PROCESS | 28912 | RSS: Main: 189710336 04:51:49 INFO - PROCESS | 28912 | 04:54:51 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-ext.html (next: http://localhost:42769/tests/dromaeo/cssquery-jquery.html) 04:54:52 INFO - PROCESS | 28912 | RSS: Main: 188219392 04:54:52 INFO - PROCESS | 28912 | 04:57:54 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42769/tests/dromaeo/cssquery-mootools.html) 04:57:54 INFO - PROCESS | 28912 | RSS: Main: 190341120 04:57:54 INFO - PROCESS | 28912 | 05:00:56 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42769/tests/dromaeo/cssquery-prototype.html) 05:00:57 INFO - PROCESS | 28912 | RSS: Main: 187506688 05:00:57 INFO - PROCESS | 28912 | 05:03:59 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42769/tests/dromaeo/cssquery-yui.html) 05:04:00 INFO - PROCESS | 28912 | RSS: Main: 189419520 05:04:00 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | Cycle 1(1): loaded http://localhost:42769/tests/dromaeo/cssquery-yui.html (next: http://localhost:42769/tests/dromaeo/cssquery-dojo.html) 05:07:03 INFO - PROCESS | 28912 | RSS: Main: 190152704 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | __start_tp_report 05:07:03 INFO - PROCESS | 28912 | _x_x_mozilla_page_load 05:07:03 INFO - PROCESS | 28912 | _x_x_mozilla_page_load_details 05:07:03 INFO - PROCESS | 28912 | |i|pagename|runs| 05:07:03 INFO - PROCESS | 28912 | |0;dojo.html;2609.1911507432696;2624.4751049790034;2651.217890722237;2662.161419152968;2682.329417645589;4879.14614942385;4896.6327525435645;4902.117618828609;4914.041761856435;4919.950800491994;4859.076775412669;4938.481459446752;4965.925511117336;4982.975085124578;5004.399472063357;4506.639468842484;4526.52471490492;4583.427071616048;4633.119707255628;4698.130845793539;4536.228841097021;4627.8148874045;4666.1367646985245;4671.719696818185;4683.69555978862;4483.551644835523;4493.370928070073;4526.298423744325;4551.772411379435;4598;4524.11779702958;4526.773661316921;4545.272756359;4560.065186636732;4590.816367345302;4498.572635599613;4501.887452813673;4516.322551617251;4538.841140560097;4573.765083427489;4815.686980346266;4878.097551952865;4937.432195297551;4944.950550494521;4959.7024178549045;5248.606354523387;5265.183896496049;5267.920981185285;5297.629165958385;5358.035553600351;5172.741362931838;5330.7334633268565;5339.279197308352;5339.652922560022;5340.49265319794;4921.729304888229;4969.37882764658;4979.4771548987555;4986.576141027981;4993.350864387679;5471.616986810965;5482.698451585201;5487.341519017744;5506.146547285097;5556.805511807067;5097.541221290027;5180.222966555047;5230.869228269247;5249.002689488985;5265.157574788015;5320.840374788762;5327.547158491571;5331.786728530893;5346.117890548016;5410.48600382963;5147.613928955343;5260.552853007461;5271.393789714155;5313.282706834605;5343.4389389113585;5148.588112950955;5317.973410132925;5328.493793089728;5338.652987555796;5361.490658387447;4517.480489743722;4548.204064288736;4569.314602809539;4570.88572785683;4573.565511276423;3913.295606790805;3916.6083391660604;3919.980400097981;3936.291467535871;3963.88108356744;4459.9777001115435;4562.178807814559;4572.862814115582;4628.236341003697;4670.019295947821;5383.16560933056;5403.8108666196495;5430.239766432703;5438.809641662523;5478.123500239943;4588.357629931812;4591.770411479412;4600.4479462464715;4609.423822022247;4612.377329060534;4710.576048155683;4723.244280915106;4755.286706993909;4813.278008298713;4909.2881532177635;4939.481354457874;4939.827106051271;4944.703317800943;4953.455119936732;4997.075541024922;5282.181261904411;5293.761780719799;5300.761465734128;5303.522682958553;5336.226247194213;4890.731009794353;4920.2619607057795;4976.900461990667;4988.45127036033;5031.496850314939;5288.7355632219005;5291;5304.443033481583;5308.071087559739;5308.416074231909;5386.622936394415;5388.946110538845;5389.83830485086;5392.487713667196;5434.75543600531;5024.120778863758;5080.847574572621;5117.385913690381;5140.254663073759;5175.9741201293755;5074.695518268915;5090.898182036264;5122.436531981404;5158.484151584811;5162.741862906914;5052.317937078447;5071.797128114834;5082.644214904921;5084.771185296744;5118.872028199325;5088.2876397305145;5098.592112631055;5117.820876269313;5205.635605507729;5207.609429292894;4961.900761984813;5029.29589857413;5050.444451110301;5051.696898186121;5090.134677104975 05:07:03 INFO - PROCESS | 28912 | |1;ext.html;540.5300681959081;583.7577405376769;594.9464548190665;602.6685323072309;617.4103730936955;33583.32833343335;38019.80990095049;38192.236155276914;38235;38269.0432739181;38367.61632383675;38507.42238866419;38621.22757544847;38685.419718704245;38758;7768.417368697342;7863.410244231677;7868.724594639189;7892.250236227549;7893.052833659969;7759.107702614215;7859.528428294292;7876;7882.408819338544;7902;7850.842983140334;7878.330341920943;7880.290773830354;7912.090109637379;7945.801354966115;7837.216278372174;7840.294373506384;7848.568328741917;7849.0581130264445;7892.644830982619;7802.33680137189;7868.76393708184;7878.566678832662;7894.3289820365335;7906.841863162762;30636.38727225443;36839;37189.62810371889;37211.069723256864;37283.25433491342;3045.1473587395344;3067.4018566379564;3131.7181453669277;3170.445172094874;3228.9667306461943;27159;27635.309117272027;27854.721452785416;27946.580801287997;28455.146345609664;3378.8986330410125;3426.691597756214;3427.1946092668204;3445.3970555152746;3464.255185135208;229351.82592696272;229425;230861;232748;233252;30825.229369265948;31097.53353699651;31321;31332.530012049836;32185.35629287401;32401.837990810367;34014.82992585071;34210.657893421245;34234.82882585621;34246;13232.669183270302;13274.66813329655;13300.334983250992;13436.126651767603;13452.260125693181;11186;11280.2667826591;11297.26567773092;11309.604163854226;11324.433778311051;7935;7959.363250939911;7996.32031277348;8049.114597394282;8051;3079.8614062367246;3135.7021082997535;3139.199504126433;3177.53925680775;3212.100611828692;891.1712107739735;908.418612088264;938.3150300280834;948.9145976862116;959.467495539968;26692.46615067688;27291.590626140623;27342.179734607995;27378.315542111606;27629.447411052068;976.1848856205148;982.5922242269378;983.2822039910762;1018.6638409324905;1072.6835583502886;14399.856001440061;14597.562073137822;14693.853061469463;14746.188959607325;14817.40730370773;383583;387726;387869;388718;388721;48807.26789098166;49782.75108624434;49787.75106124446;49796.50203497919;50048;1197.3953153657346;1207.1410028556102;1215.975680486403;1219.2257916223261;1222.5537678747194;26236.344091397867;26753.598696019188;27174;27200.455990879676;27222.319442013315;41245.175096498504;41288.587114129674;41400.79299603483;41536.79231603823;41565.37651935163;310517;311422;312148;312319;312689;24893.502129957662;25134.497310054063;25304;25840.870795646653;25927.61108583335;41301.586984129775;42014.159716806105;42167.789161053995;42286;42470.150596988504;35510.64489355177;35716.82141589275;36211.27577448489;36439.27121457503;36628.45057324089;34702.30595388129;35651;36026.27947441089;36082.27835443224;36582;34539.654603453644;34765.82617086898;35285.29429411449;35517;35605.28789424145;29874;31633.5254971171;31821.20446988844;31956.52065218977;32267.51598726068;24933.252002439956;24982.50034999326;25515;25555.744442555337;25619.23142305734 05:07:03 INFO - PROCESS | 28912 | |2;jquery.html;368.530124091783;372.6478477838442;378.88065259443255;385.26606814019283;392.6525025352562;15758.369665213391;16402.179891005446;17026.489205323862;17125.14374281284;17215.311387544498;15575.3645867184;15703.450379236701;16771.161441927918;16785.580360490992;16846.57883552912;4899.877503062426;5036.043151801165;5075.593952483811;5077;5083.872903177432;3738.8504459821575;5246.554042906358;5941.4355636214705;6256.0615907613765;6262.906056409135;6132.938670613281;6218.937810621904;6241.282252540947;6318.115463835044;6333.3666633336525;6098.939010609882;6293.842653933642;6294.43350098491;6310.337414571472;6311.274203466592;5467.234587157801;5484.506394424521;5501.669899805985;5515.448455154493;5520.779168833242;20315.695264571044;20590.897045514826;20756.58486830255;21235.25676601327;21262;1967.5769709512524;1972.2308299763104;1997.5605366819423;2001.35956493922;2007.0065317667702;13352.132111412824;13367.465301387932;13389.598312050653;13451.66370840727;13452.932735336359;1745.5548835046982;1750.3786155914595;1798.1638538079726;1853.9629207415776;1875.803040680736;64116.35883641197;65246.67376663086;65492.34507654863;66000.3399965999;66031.339686603;9605.855912161323;9776.560054797552;9984.251181161297;10046.949765251127;10111.797764044677;13506.459741610422;13546.390412431465;13591.932040339932;13630.318484075757;13639.113457625223;7471.402287816962;7514.549127052394;7541.5475071495885;7621.885671714928;7753.069631644126;7133.5719856808755;7313.122425308997;7564.243575642392;7572.848543029108;7713.1515533291295;6120.663363515049;6205.441510264008;6287.339829317947;6357.1735674362035;6416.582922110048;1599.7521932892362;1664.9334026639042;1746.1705689797245;1767.8773978523473;1866.4587269691638;825.8100636853437;853.4367317570374;938.6714649872627;942.665353799405;976.3263348289657;17128.74306885398;17287.74068388975;17488.82511174872;17740.11299435023;17929.462116136536;839.8950131233596;888.760034790603;896.9686060987834;934.1732566678538;956.9282403707891;9819.312648114563;10054.64808731691;10146.594136234615;10164.745881353025;10224.437655928847;395945;405312;406968;410136;411556;67457.32542674609;69179.3082069183;69324.30675693178;69451.65274173596;70421.2957870425;909.5588639509832;913.1370854542394;928.5218112671979;935.5649622925372;939.2298315381322;15505.534833955;15817.525474235792;15831.762523561925;16064.678706425571;16125.274362653474;34421.82789086038;35062.29875402529;36610.63389366072;39687;39698.40452393274;48400;52713.7364313176;52739;54201.728991356365;55826.16260756173;7407.740729074457;7868.449208555347;7885.802854928444;7918.485298455582;7927.246911543394;8612.009618893908;10768.723984068743;10845.674629761119;11999.64001079969;12563.309018004098;10173.76402367332;10201.897981020094;10326.638567650096;10487.475626218506;10733.570657173626;10337.17302615804;10548.525316360628;10634.8936510637;10748.946255268673;10995.395253261147;10280.22898282617;10587.258891877495;10779.622713205;10844.186685998424;10917.39954302521;7984.441089123706;8005.759827205193;8008.559529225716;8095.150009248944;8113.634886430007;7971.282584567185;10222.539985700512;10553.63062292816;10588;10608.363498190134 05:07:03 INFO - PROCESS | 28912 | |3;mootools.html;1350.149405874299;1409.2953523238382;1456.7450696128176;1613.540141059798;1639.8770092243085;6726.899096513544;7428.331450169484;7644.312011918926;7994.240547148019;8000.599970001498;7754.185810489902;7777.377809775218;7800.2199780021965;7820.296173344398;7844.52932824031;2171.023039632164;2206.172685243034;2224.7775222477785;2224.855384400017;2227.498812767131;2170.1861801824316;2217.756046834847;2220.9333719988426;2221.056051178251;2235.307054813005;2160.567886422714;2170.4248374180856;2179.5096103376773;2182.3452964110784;2191.3097374327035;2135.3166986564306;2165.534410101836;2167.0248388225364;2169.6203164446238;2177.314146043991;2140.529083601605;2158.1475317249597;2173.5326904715403;2177.401214665964;2191.638379667353;7752.651130699076;7777.416693747991;7844.4901081429525;7848;7888.605569721491;4644.837430689943;4730;4753.904921901542;4758.976205118987;4782.736949467812;2960.5263157894633;3061.0969763919475;3090.4128215638957;3123.46901026826;3133.8433078345993;942.6512190489562;954.2080073538946;959.9616015359377;967.1489089601106;974.848898420746;10616.256862019662;10622.840657390068;10675.199360047949;10679.679609611723;10688.14494840411;4216.819290598637;4299.333603291495;4386.385905973167;4400.625946794495;4416.911661766747;9084.545772711337;9105.590248438835;9106.544672766335;9113.772155696028;9123.406978546373;4868.561829435368;4868.61051115917;4868.902621947612;4869.878253043631;4877.9024419512125;3745.8688945886765;4268.359746038119;4353.499347575006;4387.692861499664;4430.246858034142;3680.981595092061;3722.4230244312175;3769.208466222069;3807.8286477108595;3820.7707537547835;1175.753091850721;1185.1526158796503;1204.4339160594507;1209.3167360441323;1217.1540779158577;752.3830459023549;758.3402439877342;830.9210624990616;833.3624777045565;841.3941961787503;5029.748512574357;5030.899382012412;5097.8725531862;5134.922976155361;5147.0992576298995;404.7510780869744;405.77885052646377;407.78998815609987;433.5621022767028;442.59723651477003;3384.509246159293;3394.8811791587177;3411.5564976553387;3422.828858557062;3430.5368775215525;9324.11420915012;9484.19384352324;9551.808963820684;9774.12032917041;9779.65771198019;9627.855582166274;9735.902640973642;9740.951295243478;9740.999999999858;9757.463339516253;7295.234000429985;7297.70809167638;7306.780796576111;7405.851882962311;7413.406927445792;5017.2724954880605;5034.572061374824;5047.192449208256;5159.793608255628;5210.088234558862;8931.598078086632;9004;9030.954845225731;9085.227755640844;9096.681616143667;9072.546372681472;9074.500902450165;9138.771530711785;9163.037881022397;9208.309376796633;6066.666333351708;6866.073080134118;6893.20728116273;6895.620740859301;7029.507934444539;7617.466777325756;7672.002639656809;7722.961385193038;7757.418193635387;7758.379329653727;6837.726490940307;7045.859082818212;7058.294170582901;7130.322619351154;7178.892316615151;6909.067275917687;6944.201416837129;6955.374016338554;6977.79066628002;7038.718451261892;5820.5925585210325;5820.76716931318;5965.761369545169;5970.671613061323;5984.401559843981;4447.688661793643;4489.753063581535;4524.88687782808;4543.432070991126;4600.803791014428;4377.321515165155;4378.80295386702;4502.977485112553;4530.071335376306;4544.568266014723 05:07:03 INFO - PROCESS | 28912 | |4;prototype.html;286.7906428307337;300.45017617759504;302.895501052137;310.30336893673706;313.9058282515245;4994.027359193116;5000.924986125211;5135.666181698187;5218.947810521899;5226.242194881745;5102;5152.021115987969;5172.870678233046;5184.585233181346;5193.818216362419;3954.1498577805764;3986.2824691555506;3996.160806230695;4000.4999375078114;4010.3958416633286;3925.1168487090463;3987.820548075329;4000.379941109118;4002.5397079335958;4014.8193331300017;3934.4885164928664;3948.763074215542;3953.3476976298875;3963.2073585282915;3970.344893092636;3951.1702542465973;3958.307296223164;3965.385365268388;4004.7797371144575;4014.8996275093064;3524.1542029912894;3527.3121741260466;3528.4883691864793;3551.5738111426535;3563.6614521620663;4840.201366774478;5001.924971125436;5002.299678045077;5008.048470790538;5117.8464646060675;4452.220861349251;4527.864164075083;4540.841070562515;4579.427571553556;4581.908361832778;5398.946010539884;5412.188171774265;5416.864578385533;5424.64028147757;5431.565474762009;3769.6230376962358;3841.5582208045876;3845.3270677631303;3847.7883716395586;3871.9612803871883;5622.91565626516;5657.6322539035245;5684.403137670568;5692.971535142339;5721.313442386899;3927.155661532784;3973.264945985002;3994.540627827837;4002.6197511236387;4010.5588385277597;3928.371460566296;3955.367141257385;3965.722399432012;4065.1463192729266;4070.7150499465347;4493.326001099796;4505.932411013838;4516.8193272268745;4527.253003254492;4535.138323718483;5361.195820626859;5371.194320851825;5373.704446255415;5386.218998245311;5441.700706461103;1298.8246586710673;1357.3077730357588;1378.7311474262422;1381.4888491258098;1392.7284179584883;878.9428687135315;879.4986857491297;890.5057692980458;904.624580798961;913.8263729891299;4172.374143878382;4191.601797829201;4203.747775133441;4206.390073439334;4239.533651298417;4859.659823812299;4916.213405855117;4927.211646136601;4953.2074868020945;4963.8014479421145;4178.8537401190815;4193.601607847249;4201.390798334285;4204.62158405745;4219.2194444027955;2455.8457524963237;2560.3215147985798;2628.6451329070333;2635.0118705485443;2636.6308716779668;4587.63298936091;4639.907201855944;4645.535446455395;4677.672562920563;4699.835505757282;4978.502149784992;4980.90038199234;5013.523715247045;5025.396952365666;5047.293378926953;4843.39457567804;5262.842174721479;5267.657602255841;5273.077211488051;5275.815346462856;5585.245991791056;5595.832125036255;5630.465105814941;5639.830805075854;5644.435556444323;5335.786568537215;5499.9175012375645;5523.447655234444;5536;5537.584681149011;5170.302009228706;5188.766505507337;5190.8183213587345;5195.246689230116;5233.973830130825;3849.9787611504184;3876.8061596920606;3877.1082650990993;3877.185790983925;3887.3197190492115;5381.246625472359;5696.658200507983;5699.373068962494;5708.885822283448;5724.198612194379;5430.266913966722;5436.130219164915;5450.073487507054;5459.099248623933;5477.589180811376;5423.915216956703;5438.18427235902;5442.510174084193;5442.727863606725;5459.727013649381;5145.974270128625;5337.919931201112;5348.224507446321;5348.224507446476;5356.625036247426;5470.343558772814;5476.424975377528;5495;5495.83989206216;5519.751611177427;5229.7836830349825;5312.140750737211;5358.901425207745;5413.864653383697;5421.864453388539 05:07:03 INFO - PROCESS | 28912 | |5;yui.html;662.7084083003479;702.5924963521159;756.678411675038;779.1935346915943;780.6916268074108;11410.429478526083;11963.820542691845;12000.81998770018;12017.158798884082;12081.577144799923;12960.48158073676;13324.666883327922;13435.596932092052;13488.393022313994;13778.93110534446;619.0590302739832;785.1951749456824;789.7907054630527;796.7370767646692;802.1937952357872;776.5845272779064;796.0208943000084;799.8440304140695;799.9240072193162;800.9199080091973;824.221111050058;830.3689196210893;833.995830020852;836.0343802907652;836.2766207230732;818.7380038387719;823.5058964621239;824.6083110522513;824.9010118785724;829.4484168028254;602.1088788592863;603.2670305578743;603.414687752879;606.5117580347818;607.808540309801;12475.625731228078;12511.249325040435;12542.937285313606;12627.368631568384;12632;12695.492180312776;13054.34728263583;13073;13078.215307081606;13159.210447373189;10342.689719308433;10617.893821061845;10749.570017199303;10834.566617335297;10940.945295273552;3355.8489867956;3379.3241351729753;3380.7295416366633;3401.200717831308;3486.3724529584665;43226.56773432257;43867.78066109649;45995.77002114968;56995.71502142504;57457.712711436594;10112.393256404639;10273.74315642115;10290.434026128634;10295.176385889112;10490.790184196274;17230.483085507203;18185.63628727418;18253.26986920535;18264.086795660165;18288.17703203359;7133.928660713326;7276.96361518189;7325.084364454443;7396.815079622945;7576.204498527685;3898.688104951597;3990.5610382857863;4022.1955608878343;4101.753894766323;4106.445629839934;2970.8068975516953;3052.435299469561;3067.2331917020747;3069.6009518762417;3069.6623371429123;522.9267902493654;526.3683579704293;537.6908277740315;542.1731858915186;543.6330476928058;547.2420697334142;624.6938999890112;630.700417301778;644.1207751419372;659.577870163096;7736.458447908705;8111.594420278962;8180.795480112925;8406.905779188075;8556.315494760403;590.7312172961292;617.5646169450616;628.4281304013326;656.4026735670517;656.4387448731361;3875.9418608720894;4106.2198182345255;4161.188568229166;4252.107057517956;4264.936025959613;88684.5565772167;94026.52986735023;96998.51500742593;97524.51237743908;98166.50916745371;81364;81681.59159204285;82483.58758206171;82815.58592207122;82942;43070.7846460772;43137.35293970593;43915;52064.739676301375;73275.63362183048;7583.27958843909;7881.645325960231;7955.1249362568915;8003.19968003195;8185.754427367188;42681.57318426776;43784.56215437805;43784.78107609441;44206;44510;55765.442345576026;56146.71926640341;58838;62601.68699156475;64063.35936640574;10230.846537301797;10366.533505992098;10929.508172132431;11461.541538338706;11467.541298347973;13235;13438.865611344152;13549.525766598123;13550.322483875963;14205.573832785032;12156.513739450676;12721.681957950756;12734.936325318315;13777.724445511234;13830.662656911687;12316.81524777147;12579.308138052495;12595.433205505591;12781.872181278068;13056.34718264064;11310.705948523408;11328.32030078198;11354.489047992694;11461.255018423775;11468.655940321803;10055.648052318134;10082.243831712503;10251.846222306522;10634.41510716887;10913.890861091288;9742.219927313192;10746.946265268936;10754.892451075702;10833.458327083772;10903.672889813319 05:07:03 INFO - PROCESS | 28912 | __end_tp_report 05:07:03 INFO - PROCESS | 28912 | __start_cc_report 05:07:03 INFO - PROCESS | 28912 | _x_x_mozilla_cycle_collect,404 05:07:03 INFO - PROCESS | 28912 | __end_cc_report 05:07:03 INFO - PROCESS | 28912 | __startTimestamp1466683623259__endTimestamp 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | ------- Summary: start ------- 05:07:03 INFO - PROCESS | 28912 | Number of tests: 6 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#0] dojo.html Cycles:165 Average:4900.12 Median:4993.35 stddev:532.63 (10.7%) stddev-sans-first:503.03 05:07:03 INFO - PROCESS | 28912 | Values: 2609.2 2624.5 2651.2 2662.2 2682.3 4879.1 4896.6 4902.1 4914.0 4920.0 4859.1 4938.5 4965.9 4983.0 5004.4 4506.6 4526.5 4583.4 4633.1 4698.1 4536.2 4627.8 4666.1 4671.7 4683.7 4483.6 4493.4 4526.3 4551.8 4598.0 4524.1 4526.8 4545.3 4560.1 4590.8 4498.6 4501.9 4516.3 4538.8 4573.8 4815.7 4878.1 4937.4 4945.0 4959.7 5248.6 5265.2 5267.9 5297.6 5358.0 5172.7 5330.7 5339.3 5339.7 5340.5 4921.7 4969.4 4979.5 4986.6 4993.4 5471.6 5482.7 5487.3 5506.1 5556.8 5097.5 5180.2 5230.9 5249.0 5265.2 5320.8 5327.5 5331.8 5346.1 5410.5 5147.6 5260.6 5271.4 5313.3 5343.4 5148.6 5318.0 5328.5 5338.7 5361.5 4517.5 4548.2 4569.3 4570.9 4573.6 3913.3 3916.6 3920.0 3936.3 3963.9 4460.0 4562.2 4572.9 4628.2 4670.0 5383.2 5403.8 5430.2 5438.8 5478.1 4588.4 4591.8 4600.4 4609.4 4612.4 4710.6 4723.2 4755.3 4813.3 4909.3 4939.5 4939.8 4944.7 4953.5 4997.1 5282.2 5293.8 5300.8 5303.5 5336.2 4890.7 4920.3 4976.9 4988.5 5031.5 5288.7 5291.0 5304.4 5308.1 5308.4 5386.6 5388.9 5389.8 5392.5 5434.8 5024.1 5080.8 5117.4 5140.3 5176.0 5074.7 5090.9 5122.4 5158.5 5162.7 5052.3 5071.8 5082.6 5084.8 5118.9 5088.3 5098.6 5117.8 5205.6 5207.6 4961.9 5029.3 5050.4 5051.7 5090.1 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#1] ext.html Cycles:180 Average:44765.63 Median:34734.07 stddev:83574.82 (240.6%) stddev-sans-first:83743.31 05:07:03 INFO - PROCESS | 28912 | Values: 540.5 583.8 594.9 602.7 617.4 33583.3 38019.8 38192.2 38235.0 38269.0 38367.6 38507.4 38621.2 38685.4 38758.0 7768.4 7863.4 7868.7 7892.3 7893.1 7759.1 7859.5 7876.0 7882.4 7902.0 7850.8 7878.3 7880.3 7912.1 7945.8 7837.2 7840.3 7848.6 7849.1 7892.6 7802.3 7868.8 7878.6 7894.3 7906.8 30636.4 36839.0 37189.6 37211.1 37283.3 3045.1 3067.4 3131.7 3170.4 3229.0 27159.0 27635.3 27854.7 27946.6 28455.1 3378.9 3426.7 3427.2 3445.4 3464.3 229351.8 229425.0 230861.0 232748.0 233252.0 30825.2 31097.5 31321.0 31332.5 32185.4 32401.8 34014.8 34210.7 34234.8 34246.0 13232.7 13274.7 13300.3 13436.1 13452.3 11186.0 11280.3 11297.3 11309.6 11324.4 7935.0 7959.4 7996.3 8049.1 8051.0 3079.9 3135.7 3139.2 3177.5 3212.1 891.2 908.4 938.3 948.9 959.5 26692.5 27291.6 27342.2 27378.3 27629.4 976.2 982.6 983.3 1018.7 1072.7 14399.9 14597.6 14693.9 14746.2 14817.4 383583.0 387726.0 387869.0 388718.0 388721.0 48807.3 49782.8 49787.8 49796.5 50048.0 1197.4 1207.1 1216.0 1219.2 1222.6 26236.3 26753.6 27174.0 27200.5 27222.3 41245.2 41288.6 41400.8 41536.8 41565.4 310517.0 311422.0 312148.0 312319.0 312689.0 24893.5 25134.5 25304.0 25840.9 25927.6 41301.6 42014.2 42167.8 42286.0 42470.2 35510.6 35716.8 36211.3 36439.3 36628.5 34702.3 35651.0 36026.3 36082.3 36582.0 34539.7 34765.8 35285.3 35517.0 35605.3 29874.0 31633.5 31821.2 31956.5 32267.5 24933.3 24982.5 25515.0 25555.7 25619.2 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#2] jquery.html Cycles:180 Average:24767.43 Median:222505.20 stddev:66668.33 (30.0%) stddev-sans-first:66830.18 05:07:03 INFO - PROCESS | 28912 | Values: 368.5 372.6 378.9 385.3 392.7 15758.4 16402.2 17026.5 17125.1 17215.3 15575.4 15703.5 16771.2 16785.6 16846.6 4899.9 5036.0 5075.6 5077.0 5083.9 3738.9 5246.6 5941.4 6256.1 6262.9 6132.9 6218.9 6241.3 6318.1 6333.4 6098.9 6293.8 6294.4 6310.3 6311.3 5467.2 5484.5 5501.7 5515.4 5520.8 20315.7 20590.9 20756.6 21235.3 21262.0 1967.6 1972.2 1997.6 2001.4 2007.0 13352.1 13367.5 13389.6 13451.7 13452.9 1745.6 1750.4 1798.2 1854.0 1875.8 64116.4 65246.7 65492.3 66000.3 66031.3 9605.9 9776.6 9984.3 10046.9 10111.8 13506.5 13546.4 13591.9 13630.3 13639.1 7471.4 7514.5 7541.5 7621.9 7753.1 7133.6 7313.1 7564.2 7572.8 7713.2 6120.7 6205.4 6287.3 6357.2 6416.6 1599.8 1664.9 1746.2 1767.9 1866.5 825.8 853.4 938.7 942.7 976.3 17128.7 17287.7 17488.8 17740.1 17929.5 839.9 888.8 897.0 934.2 956.9 9819.3 10054.6 10146.6 10164.7 10224.4 395945.0 405312.0 406968.0 410136.0 411556.0 67457.3 69179.3 69324.3 69451.7 70421.3 909.6 913.1 928.5 935.6 939.2 15505.5 15817.5 15831.8 16064.7 16125.3 34421.8 35062.3 36610.6 39687.0 39698.4 48400.0 52713.7 52739.0 54201.7 55826.2 7407.7 7868.4 7885.8 7918.5 7927.2 8612.0 10768.7 10845.7 11999.6 12563.3 10173.8 10201.9 10326.6 10487.5 10733.6 10337.2 10548.5 10634.9 10748.9 10995.4 10280.2 10587.3 10779.6 10844.2 10917.4 7984.4 8005.8 8008.6 8095.2 8113.6 7971.3 10222.5 10553.6 10588.0 10608.4 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#3] mootools.html Cycles:180 Average:5153.91 Median:5023.51 stddev:2908.80 (57.9%) stddev-sans-first:2902.91 05:07:03 INFO - PROCESS | 28912 | Values: 1350.1 1409.3 1456.7 1613.5 1639.9 6726.9 7428.3 7644.3 7994.2 8000.6 7754.2 7777.4 7800.2 7820.3 7844.5 2171.0 2206.2 2224.8 2224.9 2227.5 2170.2 2217.8 2220.9 2221.1 2235.3 2160.6 2170.4 2179.5 2182.3 2191.3 2135.3 2165.5 2167.0 2169.6 2177.3 2140.5 2158.1 2173.5 2177.4 2191.6 7752.7 7777.4 7844.5 7848.0 7888.6 4644.8 4730.0 4753.9 4759.0 4782.7 2960.5 3061.1 3090.4 3123.5 3133.8 942.7 954.2 960.0 967.1 974.8 10616.3 10622.8 10675.2 10679.7 10688.1 4216.8 4299.3 4386.4 4400.6 4416.9 9084.5 9105.6 9106.5 9113.8 9123.4 4868.6 4868.6 4868.9 4869.9 4877.9 3745.9 4268.4 4353.5 4387.7 4430.2 3681.0 3722.4 3769.2 3807.8 3820.8 1175.8 1185.2 1204.4 1209.3 1217.2 752.4 758.3 830.9 833.4 841.4 5029.7 5030.9 5097.9 5134.9 5147.1 404.8 405.8 407.8 433.6 442.6 3384.5 3394.9 3411.6 3422.8 3430.5 9324.1 9484.2 9551.8 9774.1 9779.7 9627.9 9735.9 9741.0 9741.0 9757.5 7295.2 7297.7 7306.8 7405.9 7413.4 5017.3 5034.6 5047.2 5159.8 5210.1 8931.6 9004.0 9031.0 9085.2 9096.7 9072.5 9074.5 9138.8 9163.0 9208.3 6066.7 6866.1 6893.2 6895.6 7029.5 7617.5 7672.0 7723.0 7757.4 7758.4 6837.7 7045.9 7058.3 7130.3 7178.9 6909.1 6944.2 6955.4 6977.8 7038.7 5820.6 5820.8 5965.8 5970.7 5984.4 4447.7 4489.8 4524.9 4543.4 4600.8 4377.3 4378.8 4503.0 4530.1 4544.6 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#4] prototype.html Cycles:180 Average:4395.29 Median:4958.50 stddev:1300.71 (26.2%) stddev-sans-first:1267.28 05:07:03 INFO - PROCESS | 28912 | Values: 286.8 300.5 302.9 310.3 313.9 4994.0 5000.9 5135.7 5218.9 5226.2 5102.0 5152.0 5172.9 5184.6 5193.8 3954.1 3986.3 3996.2 4000.5 4010.4 3925.1 3987.8 4000.4 4002.5 4014.8 3934.5 3948.8 3953.3 3963.2 3970.3 3951.2 3958.3 3965.4 4004.8 4014.9 3524.2 3527.3 3528.5 3551.6 3563.7 4840.2 5001.9 5002.3 5008.0 5117.8 4452.2 4527.9 4540.8 4579.4 4581.9 5398.9 5412.2 5416.9 5424.6 5431.6 3769.6 3841.6 3845.3 3847.8 3872.0 5622.9 5657.6 5684.4 5693.0 5721.3 3927.2 3973.3 3994.5 4002.6 4010.6 3928.4 3955.4 3965.7 4065.1 4070.7 4493.3 4505.9 4516.8 4527.3 4535.1 5361.2 5371.2 5373.7 5386.2 5441.7 1298.8 1357.3 1378.7 1381.5 1392.7 878.9 879.5 890.5 904.6 913.8 4172.4 4191.6 4203.7 4206.4 4239.5 4859.7 4916.2 4927.2 4953.2 4963.8 4178.9 4193.6 4201.4 4204.6 4219.2 2455.8 2560.3 2628.6 2635.0 2636.6 4587.6 4639.9 4645.5 4677.7 4699.8 4978.5 4980.9 5013.5 5025.4 5047.3 4843.4 5262.8 5267.7 5273.1 5275.8 5585.2 5595.8 5630.5 5639.8 5644.4 5335.8 5499.9 5523.4 5536.0 5537.6 5170.3 5188.8 5190.8 5195.2 5234.0 3850.0 3876.8 3877.1 3877.2 3887.3 5381.2 5696.7 5699.4 5708.9 5724.2 5430.3 5436.1 5450.1 5459.1 5477.6 5423.9 5438.2 5442.5 5442.7 5459.7 5146.0 5337.9 5348.2 5348.2 5356.6 5470.3 5476.4 5495.0 5495.8 5519.8 5229.8 5312.1 5358.9 5413.9 5421.9 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - PROCESS | 28912 | [#5] yui.html Cycles:180 Average:16613.29 Median:43104.07 stddev:23043.21 (53.5%) stddev-sans-first:23076.73 05:07:03 INFO - PROCESS | 28912 | Values: 662.7 702.6 756.7 779.2 780.7 11410.4 11963.8 12000.8 12017.2 12081.6 12960.5 13324.7 13435.6 13488.4 13778.9 619.1 785.2 789.8 796.7 802.2 776.6 796.0 799.8 799.9 800.9 824.2 830.4 834.0 836.0 836.3 818.7 823.5 824.6 824.9 829.4 602.1 603.3 603.4 606.5 607.8 12475.6 12511.2 12542.9 12627.4 12632.0 12695.5 13054.3 13073.0 13078.2 13159.2 10342.7 10617.9 10749.6 10834.6 10940.9 3355.8 3379.3 3380.7 3401.2 3486.4 43226.6 43867.8 45995.8 56995.7 57457.7 10112.4 10273.7 10290.4 10295.2 10490.8 17230.5 18185.6 18253.3 18264.1 18288.2 7133.9 7277.0 7325.1 7396.8 7576.2 3898.7 3990.6 4022.2 4101.8 4106.4 2970.8 3052.4 3067.2 3069.6 3069.7 522.9 526.4 537.7 542.2 543.6 547.2 624.7 630.7 644.1 659.6 7736.5 8111.6 8180.8 8406.9 8556.3 590.7 617.6 628.4 656.4 656.4 3875.9 4106.2 4161.2 4252.1 4264.9 88684.6 94026.5 96998.5 97524.5 98166.5 81364.0 81681.6 82483.6 82815.6 82942.0 43070.8 43137.4 43915.0 52064.7 73275.6 7583.3 7881.6 7955.1 8003.2 8185.8 42681.6 43784.6 43784.8 44206.0 44510.0 55765.4 56146.7 58838.0 62601.7 64063.4 10230.8 10366.5 10929.5 11461.5 11467.5 13235.0 13438.9 13549.5 13550.3 14205.6 12156.5 12721.7 12734.9 13777.7 13830.7 12316.8 12579.3 12595.4 12781.9 13056.3 11310.7 11328.3 11354.5 11461.3 11468.7 10055.6 10082.2 10251.8 10634.4 10913.9 9742.2 10746.9 10754.9 10833.5 10903.7 05:07:03 INFO - PROCESS | 28912 | -------- Summary: end -------- 05:07:03 INFO - PROCESS | 28912 | 05:07:03 INFO - TEST-INFO | 28912: exit 0 05:07:04 INFO - TEST-OK | dromaeo_css | took 1116875ms 05:07:04 INFO - TEST-START | kraken 05:07:04 INFO - operating with platform_type : linux_ 05:07:04 INFO - Initialising browser for kraken test... 05:07:04 INFO - TEST-INFO | started process 29144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAMb9G/profile http://localhost:42769/getInfo.html) 05:07:09 INFO - PROCESS | 29144 | __metrics Screen width/height:1600/1200 05:07:09 INFO - PROCESS | 29144 | colorDepth:24 05:07:09 INFO - PROCESS | 29144 | Browser inner width/height: 1024/697 05:07:09 INFO - PROCESS | 29144 | __metrics 05:07:09 ERROR - PROCESS | 29144 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:07:10 INFO - TEST-INFO | 29144: exit 0 05:07:10 INFO - Browser initialized. 05:07:10 INFO - Running cycle 1/1 for kraken test... 05:07:10 INFO - TEST-INFO | started process 29262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAMb9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:22 INFO - PROCESS | 29262 | RSS: Main: 186097664 05:07:22 INFO - PROCESS | 29262 | 05:07:25 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42769/tests/kraken/driver.html?testName=audio-beat-detection) 05:07:26 INFO - PROCESS | 29262 | RSS: Main: 191049728 05:07:26 INFO - PROCESS | 29262 | 05:07:29 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42769/tests/kraken/driver.html?testName=audio-dft) 05:07:29 INFO - PROCESS | 29262 | RSS: Main: 190894080 05:07:29 INFO - PROCESS | 29262 | 05:07:32 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42769/tests/kraken/driver.html?testName=audio-fft) 05:07:33 INFO - PROCESS | 29262 | RSS: Main: 186630144 05:07:33 INFO - PROCESS | 29262 | 05:07:35 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42769/tests/kraken/driver.html?testName=audio-oscillator) 05:07:36 INFO - PROCESS | 29262 | RSS: Main: 187432960 05:07:36 INFO - PROCESS | 29262 | 05:07:38 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:39 INFO - PROCESS | 29262 | RSS: Main: 187928576 05:07:39 INFO - PROCESS | 29262 | 05:07:42 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42769/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:43 INFO - PROCESS | 29262 | RSS: Main: 188235776 05:07:43 INFO - PROCESS | 29262 | 05:07:46 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42769/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:47 INFO - PROCESS | 29262 | RSS: Main: 185225216 05:07:47 INFO - PROCESS | 29262 | 05:07:50 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42769/tests/kraken/driver.html?testName=json-parse-financial) 05:07:50 INFO - PROCESS | 29262 | RSS: Main: 186585088 05:07:50 INFO - PROCESS | 29262 | 05:07:52 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:53 INFO - PROCESS | 29262 | RSS: Main: 186937344 05:07:53 INFO - PROCESS | 29262 | 05:07:55 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:55 INFO - PROCESS | 29262 | RSS: Main: 186945536 05:07:55 INFO - PROCESS | 29262 | 05:07:57 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:58 INFO - PROCESS | 29262 | RSS: Main: 187076608 05:07:58 INFO - PROCESS | 29262 | 05:08:01 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:02 INFO - PROCESS | 29262 | RSS: Main: 187977728 05:08:02 INFO - PROCESS | 29262 | 05:08:04 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:05 INFO - PROCESS | 29262 | RSS: Main: 187420672 05:08:05 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | Cycle 1(1): loaded http://localhost:42769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42769/tests/kraken/driver.html?testName=ai-astar) 05:08:07 INFO - PROCESS | 29262 | RSS: Main: 188395520 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | __start_tp_report 05:08:07 INFO - PROCESS | 29262 | _x_x_mozilla_page_load 05:08:07 INFO - PROCESS | 29262 | _x_x_mozilla_page_load_details 05:08:07 INFO - PROCESS | 29262 | |i|pagename|runs| 05:08:07 INFO - PROCESS | 29262 | |0;ai-astar;105;115;107;117;113;116;116;114;113;114 05:08:07 INFO - PROCESS | 29262 | |1;audio-beat-detection;160;138;156;180;133;160;162;137;190;142 05:08:07 INFO - PROCESS | 29262 | |2;audio-dft;162;168;173;163;161;163;163;164;163;162 05:08:07 INFO - PROCESS | 29262 | |3;audio-fft;76;79;76;166;79;76;77;75;168;80 05:08:07 INFO - PROCESS | 29262 | |4;audio-oscillator;87;87;142;86;86;88;131;87;88;134 05:08:07 INFO - PROCESS | 29262 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;118;118;118 05:08:07 INFO - PROCESS | 29262 | |6;imaging-darkroom;149;151;149;148;148;148;148;149;147;149 05:08:07 INFO - PROCESS | 29262 | |7;imaging-desaturate;95;95;97;95;96;95;95;95;95;96 05:08:07 INFO - PROCESS | 29262 | |8;json-parse-financial;65;63;65;65;66;64;64;64;64;63 05:08:07 INFO - PROCESS | 29262 | |9;json-stringify-tinderbox;65;65;65;64;64;66;65;65;65;66 05:08:07 INFO - PROCESS | 29262 | |10;stanford-crypto-aes;82;82;82;86;91;84;83;86;100;83 05:08:07 INFO - PROCESS | 29262 | |11;stanford-crypto-ccm;136;133;131;151;130;134;140;149;131;132 05:08:07 INFO - PROCESS | 29262 | |12;stanford-crypto-pbkdf2;175;167;174;171;173;175;174;171;166;167 05:08:07 INFO - PROCESS | 29262 | |13;stanford-crypto-sha256-iterative;69;67;67;69;69;68;66;70;68;66 05:08:07 INFO - PROCESS | 29262 | __end_tp_report 05:08:07 INFO - PROCESS | 29262 | __start_cc_report 05:08:07 INFO - PROCESS | 29262 | _x_x_mozilla_cycle_collect,973 05:08:07 INFO - PROCESS | 29262 | __end_cc_report 05:08:07 INFO - PROCESS | 29262 | __startTimestamp1466683687612__endTimestamp 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | ------- Summary: start ------- 05:08:07 INFO - PROCESS | 29262 | Number of tests: 14 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:3.94 (3.4%) stddev-sans-first:2.93 05:08:07 INFO - PROCESS | 29262 | Values: 105.0 115.0 107.0 117.0 113.0 116.0 116.0 114.0 113.0 114.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:160.00 stddev:18.88 (11.8%) stddev-sans-first:19.97 05:08:07 INFO - PROCESS | 29262 | Values: 160.0 138.0 156.0 180.0 133.0 160.0 162.0 137.0 190.0 142.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:3.61 (2.2%) stddev-sans-first:3.75 05:08:07 INFO - PROCESS | 29262 | Values: 162.0 168.0 173.0 163.0 161.0 163.0 163.0 164.0 163.0 162.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.50 stddev:37.88 (49.5%) stddev-sans-first:39.53 05:08:07 INFO - PROCESS | 29262 | Values: 76.0 79.0 76.0 166.0 79.0 76.0 77.0 75.0 168.0 80.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:87.00 stddev:23.67 (27.2%) stddev-sans-first:24.51 05:08:07 INFO - PROCESS | 29262 | Values: 87.0 87.0 142.0 86.0 86.0 88.0 131.0 87.0 88.0 134.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:08:07 INFO - PROCESS | 29262 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:08:07 INFO - PROCESS | 29262 | Values: 149.0 151.0 149.0 148.0 148.0 148.0 148.0 149.0 147.0 149.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:08:07 INFO - PROCESS | 29262 | Values: 95.0 95.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 05:08:07 INFO - PROCESS | 29262 | Values: 65.0 63.0 65.0 65.0 66.0 64.0 64.0 64.0 64.0 63.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:08:07 INFO - PROCESS | 29262 | Values: 65.0 65.0 65.0 64.0 64.0 66.0 65.0 65.0 65.0 66.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:83.50 stddev:5.69 (6.8%) stddev-sans-first:5.85 05:08:07 INFO - PROCESS | 29262 | Values: 82.0 82.0 82.0 86.0 91.0 84.0 83.0 86.0 100.0 83.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:135.00 stddev:7.60 (5.6%) stddev-sans-first:8.06 05:08:07 INFO - PROCESS | 29262 | Values: 136.0 133.0 131.0 151.0 130.0 134.0 140.0 149.0 131.0 132.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:173.50 stddev:3.50 (2.0%) stddev-sans-first:3.44 05:08:07 INFO - PROCESS | 29262 | Values: 175.0 167.0 174.0 171.0 173.0 175.0 174.0 171.0 166.0 167.0 05:08:07 INFO - PROCESS | 29262 | 05:08:07 INFO - PROCESS | 29262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.37 (2.0%) stddev-sans-first:1.39 05:08:07 INFO - PROCESS | 29262 | Values: 69.0 67.0 67.0 69.0 69.0 68.0 66.0 70.0 68.0 66.0 05:08:07 INFO - PROCESS | 29262 | -------- Summary: end -------- 05:08:07 INFO - PROCESS | 29262 | 05:08:08 INFO - TEST-INFO | 29262: exit 0 05:08:08 INFO - TEST-OK | kraken | took 64692ms 05:08:08 INFO - SUITE-END | took 1181s 05:08:08 INFO - Completed test suite (00:19:41) 05:08:08 INFO - javascript benchmark 05:08:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6439.071847523733, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.1911507432696, 2624.4751049790034, 2651.217890722237, 2662.161419152968, 2682.329417645589, 4879.14614942385, 4896.6327525435645, 4902.117618828609, 4914.041761856435, 4919.950800491994, 4859.076775412669, 4938.481459446752, 4965.925511117336, 4982.975085124578, 5004.399472063357, 4506.639468842484, 4526.52471490492, 4583.427071616048, 4633.119707255628, 4698.130845793539, 4536.228841097021, 4627.8148874045, 4666.1367646985245, 4671.719696818185, 4683.69555978862, 4483.551644835523, 4493.370928070073, 4526.298423744325, 4551.772411379435, 4598.0, 4524.11779702958, 4526.773661316921, 4545.272756359, 4560.065186636732, 4590.816367345302, 4498.572635599613, 4501.887452813673, 4516.322551617251, 4538.841140560097, 4573.765083427489, 4815.686980346266, 4878.097551952865, 4937.432195297551, 4944.950550494521, 4959.7024178549045, 5248.606354523387, 5265.183896496049, 5267.920981185285, 5297.629165958385, 5358.035553600351, 5172.741362931838, 5330.7334633268565, 5339.279197308352, 5339.652922560022, 5340.49265319794, 4921.729304888229, 4969.37882764658, 4979.4771548987555, 4986.576141027981, 4993.350864387679, 5471.616986810965, 5482.698451585201, 5487.341519017744, 5506.146547285097, 5556.805511807067, 5097.541221290027, 5180.222966555047, 5230.869228269247, 5249.002689488985, 5265.157574788015, 5320.840374788762, 5327.547158491571, 5331.786728530893, 5346.117890548016, 5410.48600382963, 5147.613928955343, 5260.552853007461, 5271.393789714155, 5313.282706834605, 5343.4389389113585, 5148.588112950955, 5317.973410132925, 5328.493793089728, 5338.652987555796, 5361.490658387447, 4517.480489743722, 4548.204064288736, 4569.314602809539, 4570.88572785683, 4573.565511276423, 3913.295606790805, 3916.6083391660604, 3919.980400097981, 3936.291467535871, 3963.88108356744, 4459.9777001115435, 4562.178807814559, 4572.862814115582, 4628.236341003697, 4670.019295947821, 5383.16560933056, 5403.8108666196495, 5430.239766432703, 5438.809641662523, 5478.123500239943, 4588.357629931812, 4591.770411479412, 4600.4479462464715, 4609.423822022247, 4612.377329060534, 4710.576048155683, 4723.244280915106, 4755.286706993909, 4813.278008298713, 4909.2881532177635, 4939.481354457874, 4939.827106051271, 4944.703317800943, 4953.455119936732, 4997.075541024922, 5282.181261904411, 5293.761780719799, 5300.761465734128, 5303.522682958553, 5336.226247194213, 4890.731009794353, 4920.2619607057795, 4976.900461990667, 4988.45127036033, 5031.496850314939, 5288.7355632219005, 5291.0, 5304.443033481583, 5308.071087559739, 5308.416074231909, 5386.622936394415, 5388.946110538845, 5389.83830485086, 5392.487713667196, 5434.75543600531, 5024.120778863758, 5080.847574572621, 5117.385913690381, 5140.254663073759, 5175.9741201293755, 5074.695518268915, 5090.898182036264, 5122.436531981404, 5158.484151584811, 5162.741862906914, 5052.317937078447, 5071.797128114834, 5082.644214904921, 5084.771185296744, 5118.872028199325, 5088.2876397305145, 5098.592112631055, 5117.820876269313, 5205.635605507729, 5207.609429292894, 4961.900761984813, 5029.29589857413, 5050.444451110301, 5051.696898186121, 5090.134677104975], "value": 4864.023948742314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.5300681959081, 583.7577405376769, 594.9464548190665, 602.6685323072309, 617.4103730936955, 33583.32833343335, 38019.80990095049, 38192.236155276914, 38235.0, 38269.0432739181, 38367.61632383675, 38507.42238866419, 38621.22757544847, 38685.419718704245, 38758.0, 7768.417368697342, 7863.410244231677, 7868.724594639189, 7892.250236227549, 7893.052833659969, 7759.107702614215, 7859.528428294292, 7876.0, 7882.408819338544, 7902.0, 7850.842983140334, 7878.330341920943, 7880.290773830354, 7912.090109637379, 7945.801354966115, 7837.216278372174, 7840.294373506384, 7848.568328741917, 7849.0581130264445, 7892.644830982619, 7802.33680137189, 7868.76393708184, 7878.566678832662, 7894.3289820365335, 7906.841863162762, 30636.38727225443, 36839.0, 37189.62810371889, 37211.069723256864, 37283.25433491342, 3045.1473587395344, 3067.4018566379564, 3131.7181453669277, 3170.445172094874, 3228.9667306461943, 27159.0, 27635.309117272027, 27854.721452785416, 27946.580801287997, 28455.146345609664, 3378.8986330410125, 3426.691597756214, 3427.1946092668204, 3445.3970555152746, 3464.255185135208, 229351.82592696272, 229425.0, 230861.0, 232748.0, 233252.0, 30825.229369265948, 31097.53353699651, 31321.0, 31332.530012049836, 32185.35629287401, 32401.837990810367, 34014.82992585071, 34210.657893421245, 34234.82882585621, 34246.0, 13232.669183270302, 13274.66813329655, 13300.334983250992, 13436.126651767603, 13452.260125693181, 11186.0, 11280.2667826591, 11297.26567773092, 11309.604163854226, 11324.433778311051, 7935.0, 7959.363250939911, 7996.32031277348, 8049.114597394282, 8051.0, 3079.8614062367246, 3135.7021082997535, 3139.199504126433, 3177.53925680775, 3212.100611828692, 891.1712107739735, 908.418612088264, 938.3150300280834, 948.9145976862116, 959.467495539968, 26692.46615067688, 27291.590626140623, 27342.179734607995, 27378.315542111606, 27629.447411052068, 976.1848856205148, 982.5922242269378, 983.2822039910762, 1018.6638409324905, 1072.6835583502886, 14399.856001440061, 14597.562073137822, 14693.853061469463, 14746.188959607325, 14817.40730370773, 383583.0, 387726.0, 387869.0, 388718.0, 388721.0, 48807.26789098166, 49782.75108624434, 49787.75106124446, 49796.50203497919, 50048.0, 1197.3953153657346, 1207.1410028556102, 1215.975680486403, 1219.2257916223261, 1222.5537678747194, 26236.344091397867, 26753.598696019188, 27174.0, 27200.455990879676, 27222.319442013315, 41245.175096498504, 41288.587114129674, 41400.79299603483, 41536.79231603823, 41565.37651935163, 310517.0, 311422.0, 312148.0, 312319.0, 312689.0, 24893.502129957662, 25134.497310054063, 25304.0, 25840.870795646653, 25927.61108583335, 41301.586984129775, 42014.159716806105, 42167.789161053995, 42286.0, 42470.150596988504, 35510.64489355177, 35716.82141589275, 36211.27577448489, 36439.27121457503, 36628.45057324089, 34702.30595388129, 35651.0, 36026.27947441089, 36082.27835443224, 36582.0, 34539.654603453644, 34765.82617086898, 35285.29429411449, 35517.0, 35605.28789424145, 29874.0, 31633.5254971171, 31821.20446988844, 31956.52065218977, 32267.51598726068, 24933.252002439956, 24982.50034999326, 25515.0, 25555.744442555337, 25619.23142305734], "value": 16129.15555505085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.530124091783, 372.6478477838442, 378.88065259443255, 385.26606814019283, 392.6525025352562, 15758.369665213391, 16402.179891005446, 17026.489205323862, 17125.14374281284, 17215.311387544498, 15575.3645867184, 15703.450379236701, 16771.161441927918, 16785.580360490992, 16846.57883552912, 4899.877503062426, 5036.043151801165, 5075.593952483811, 5077.0, 5083.872903177432, 3738.8504459821575, 5246.554042906358, 5941.4355636214705, 6256.0615907613765, 6262.906056409135, 6132.938670613281, 6218.937810621904, 6241.282252540947, 6318.115463835044, 6333.3666633336525, 6098.939010609882, 6293.842653933642, 6294.43350098491, 6310.337414571472, 6311.274203466592, 5467.234587157801, 5484.506394424521, 5501.669899805985, 5515.448455154493, 5520.779168833242, 20315.695264571044, 20590.897045514826, 20756.58486830255, 21235.25676601327, 21262.0, 1967.5769709512524, 1972.2308299763104, 1997.5605366819423, 2001.35956493922, 2007.0065317667702, 13352.132111412824, 13367.465301387932, 13389.598312050653, 13451.66370840727, 13452.932735336359, 1745.5548835046982, 1750.3786155914595, 1798.1638538079726, 1853.9629207415776, 1875.803040680736, 64116.35883641197, 65246.67376663086, 65492.34507654863, 66000.3399965999, 66031.339686603, 9605.855912161323, 9776.560054797552, 9984.251181161297, 10046.949765251127, 10111.797764044677, 13506.459741610422, 13546.390412431465, 13591.932040339932, 13630.318484075757, 13639.113457625223, 7471.402287816962, 7514.549127052394, 7541.5475071495885, 7621.885671714928, 7753.069631644126, 7133.5719856808755, 7313.122425308997, 7564.243575642392, 7572.848543029108, 7713.1515533291295, 6120.663363515049, 6205.441510264008, 6287.339829317947, 6357.1735674362035, 6416.582922110048, 1599.7521932892362, 1664.9334026639042, 1746.1705689797245, 1767.8773978523473, 1866.4587269691638, 825.8100636853437, 853.4367317570374, 938.6714649872627, 942.665353799405, 976.3263348289657, 17128.74306885398, 17287.74068388975, 17488.82511174872, 17740.11299435023, 17929.462116136536, 839.8950131233596, 888.760034790603, 896.9686060987834, 934.1732566678538, 956.9282403707891, 9819.312648114563, 10054.64808731691, 10146.594136234615, 10164.745881353025, 10224.437655928847, 395945.0, 405312.0, 406968.0, 410136.0, 411556.0, 67457.32542674609, 69179.3082069183, 69324.30675693178, 69451.65274173596, 70421.2957870425, 909.5588639509832, 913.1370854542394, 928.5218112671979, 935.5649622925372, 939.2298315381322, 15505.534833955, 15817.525474235792, 15831.762523561925, 16064.678706425571, 16125.274362653474, 34421.82789086038, 35062.29875402529, 36610.63389366072, 39687.0, 39698.40452393274, 48400.0, 52713.7364313176, 52739.0, 54201.728991356365, 55826.16260756173, 7407.740729074457, 7868.449208555347, 7885.802854928444, 7918.485298455582, 7927.246911543394, 8612.009618893908, 10768.723984068743, 10845.674629761119, 11999.64001079969, 12563.309018004098, 10173.76402367332, 10201.897981020094, 10326.638567650096, 10487.475626218506, 10733.570657173626, 10337.17302615804, 10548.525316360628, 10634.8936510637, 10748.946255268673, 10995.395253261147, 10280.22898282617, 10587.258891877495, 10779.622713205, 10844.186685998424, 10917.39954302521, 7984.441089123706, 8005.759827205193, 8008.559529225716, 8095.150009248944, 8113.634886430007, 7971.282584567185, 10222.539985700512, 10553.63062292816, 10588.0, 10608.363498190134], "value": 8523.494576655025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.149405874299, 1409.2953523238382, 1456.7450696128176, 1613.540141059798, 1639.8770092243085, 6726.899096513544, 7428.331450169484, 7644.312011918926, 7994.240547148019, 8000.599970001498, 7754.185810489902, 7777.377809775218, 7800.2199780021965, 7820.296173344398, 7844.52932824031, 2171.023039632164, 2206.172685243034, 2224.7775222477785, 2224.855384400017, 2227.498812767131, 2170.1861801824316, 2217.756046834847, 2220.9333719988426, 2221.056051178251, 2235.307054813005, 2160.567886422714, 2170.4248374180856, 2179.5096103376773, 2182.3452964110784, 2191.3097374327035, 2135.3166986564306, 2165.534410101836, 2167.0248388225364, 2169.6203164446238, 2177.314146043991, 2140.529083601605, 2158.1475317249597, 2173.5326904715403, 2177.401214665964, 2191.638379667353, 7752.651130699076, 7777.416693747991, 7844.4901081429525, 7848.0, 7888.605569721491, 4644.837430689943, 4730.0, 4753.904921901542, 4758.976205118987, 4782.736949467812, 2960.5263157894633, 3061.0969763919475, 3090.4128215638957, 3123.46901026826, 3133.8433078345993, 942.6512190489562, 954.2080073538946, 959.9616015359377, 967.1489089601106, 974.848898420746, 10616.256862019662, 10622.840657390068, 10675.199360047949, 10679.679609611723, 10688.14494840411, 4216.819290598637, 4299.333603291495, 4386.385905973167, 4400.625946794495, 4416.911661766747, 9084.545772711337, 9105.590248438835, 9106.544672766335, 9113.772155696028, 9123.406978546373, 4868.561829435368, 4868.61051115917, 4868.902621947612, 4869.878253043631, 4877.9024419512125, 3745.8688945886765, 4268.359746038119, 4353.499347575006, 4387.692861499664, 4430.246858034142, 3680.981595092061, 3722.4230244312175, 3769.208466222069, 3807.8286477108595, 3820.7707537547835, 1175.753091850721, 1185.1526158796503, 1204.4339160594507, 1209.3167360441323, 1217.1540779158577, 752.3830459023549, 758.3402439877342, 830.9210624990616, 833.3624777045565, 841.3941961787503, 5029.748512574357, 5030.899382012412, 5097.8725531862, 5134.922976155361, 5147.0992576298995, 404.7510780869744, 405.77885052646377, 407.78998815609987, 433.5621022767028, 442.59723651477003, 3384.509246159293, 3394.8811791587177, 3411.5564976553387, 3422.828858557062, 3430.5368775215525, 9324.11420915012, 9484.19384352324, 9551.808963820684, 9774.12032917041, 9779.65771198019, 9627.855582166274, 9735.902640973642, 9740.951295243478, 9740.999999999858, 9757.463339516253, 7295.234000429985, 7297.70809167638, 7306.780796576111, 7405.851882962311, 7413.406927445792, 5017.2724954880605, 5034.572061374824, 5047.192449208256, 5159.793608255628, 5210.088234558862, 8931.598078086632, 9004.0, 9030.954845225731, 9085.227755640844, 9096.681616143667, 9072.546372681472, 9074.500902450165, 9138.771530711785, 9163.037881022397, 9208.309376796633, 6066.666333351708, 6866.073080134118, 6893.20728116273, 6895.620740859301, 7029.507934444539, 7617.466777325756, 7672.002639656809, 7722.961385193038, 7757.418193635387, 7758.379329653727, 6837.726490940307, 7045.859082818212, 7058.294170582901, 7130.322619351154, 7178.892316615151, 6909.067275917687, 6944.201416837129, 6955.374016338554, 6977.79066628002, 7038.718451261892, 5820.5925585210325, 5820.76716931318, 5965.761369545169, 5970.671613061323, 5984.401559843981, 4447.688661793643, 4489.753063581535, 4524.88687782808, 4543.432070991126, 4600.803791014428, 4377.321515165155, 4378.80295386702, 4502.977485112553, 4530.071335376306, 4544.568266014723], "value": 4080.5056714189345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.7906428307337, 300.45017617759504, 302.895501052137, 310.30336893673706, 313.9058282515245, 4994.027359193116, 5000.924986125211, 5135.666181698187, 5218.947810521899, 5226.242194881745, 5102.0, 5152.021115987969, 5172.870678233046, 5184.585233181346, 5193.818216362419, 3954.1498577805764, 3986.2824691555506, 3996.160806230695, 4000.4999375078114, 4010.3958416633286, 3925.1168487090463, 3987.820548075329, 4000.379941109118, 4002.5397079335958, 4014.8193331300017, 3934.4885164928664, 3948.763074215542, 3953.3476976298875, 3963.2073585282915, 3970.344893092636, 3951.1702542465973, 3958.307296223164, 3965.385365268388, 4004.7797371144575, 4014.8996275093064, 3524.1542029912894, 3527.3121741260466, 3528.4883691864793, 3551.5738111426535, 3563.6614521620663, 4840.201366774478, 5001.924971125436, 5002.299678045077, 5008.048470790538, 5117.8464646060675, 4452.220861349251, 4527.864164075083, 4540.841070562515, 4579.427571553556, 4581.908361832778, 5398.946010539884, 5412.188171774265, 5416.864578385533, 5424.64028147757, 5431.565474762009, 3769.6230376962358, 3841.5582208045876, 3845.3270677631303, 3847.7883716395586, 3871.9612803871883, 5622.91565626516, 5657.6322539035245, 5684.403137670568, 5692.971535142339, 5721.313442386899, 3927.155661532784, 3973.264945985002, 3994.540627827837, 4002.6197511236387, 4010.5588385277597, 3928.371460566296, 3955.367141257385, 3965.722399432012, 4065.1463192729266, 4070.7150499465347, 4493.326001099796, 4505.932411013838, 4516.8193272268745, 4527.253003254492, 4535.138323718483, 5361.195820626859, 5371.194320851825, 5373.704446255415, 5386.218998245311, 5441.700706461103, 1298.8246586710673, 1357.3077730357588, 1378.7311474262422, 1381.4888491258098, 1392.7284179584883, 878.9428687135315, 879.4986857491297, 890.5057692980458, 904.624580798961, 913.8263729891299, 4172.374143878382, 4191.601797829201, 4203.747775133441, 4206.390073439334, 4239.533651298417, 4859.659823812299, 4916.213405855117, 4927.211646136601, 4953.2074868020945, 4963.8014479421145, 4178.8537401190815, 4193.601607847249, 4201.390798334285, 4204.62158405745, 4219.2194444027955, 2455.8457524963237, 2560.3215147985798, 2628.6451329070333, 2635.0118705485443, 2636.6308716779668, 4587.63298936091, 4639.907201855944, 4645.535446455395, 4677.672562920563, 4699.835505757282, 4978.502149784992, 4980.90038199234, 5013.523715247045, 5025.396952365666, 5047.293378926953, 4843.39457567804, 5262.842174721479, 5267.657602255841, 5273.077211488051, 5275.815346462856, 5585.245991791056, 5595.832125036255, 5630.465105814941, 5639.830805075854, 5644.435556444323, 5335.786568537215, 5499.9175012375645, 5523.447655234444, 5536.0, 5537.584681149011, 5170.302009228706, 5188.766505507337, 5190.8183213587345, 5195.246689230116, 5233.973830130825, 3849.9787611504184, 3876.8061596920606, 3877.1082650990993, 3877.185790983925, 3887.3197190492115, 5381.246625472359, 5696.658200507983, 5699.373068962494, 5708.885822283448, 5724.198612194379, 5430.266913966722, 5436.130219164915, 5450.073487507054, 5459.099248623933, 5477.589180811376, 5423.915216956703, 5438.18427235902, 5442.510174084193, 5442.727863606725, 5459.727013649381, 5145.974270128625, 5337.919931201112, 5348.224507446321, 5348.224507446476, 5356.625036247426, 5470.343558772814, 5476.424975377528, 5495.0, 5495.83989206216, 5519.751611177427, 5229.7836830349825, 5312.140750737211, 5358.901425207745, 5413.864653383697, 5421.864453388539], "value": 3979.409197369401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.7084083003479, 702.5924963521159, 756.678411675038, 779.1935346915943, 780.6916268074108, 11410.429478526083, 11963.820542691845, 12000.81998770018, 12017.158798884082, 12081.577144799923, 12960.48158073676, 13324.666883327922, 13435.596932092052, 13488.393022313994, 13778.93110534446, 619.0590302739832, 785.1951749456824, 789.7907054630527, 796.7370767646692, 802.1937952357872, 776.5845272779064, 796.0208943000084, 799.8440304140695, 799.9240072193162, 800.9199080091973, 824.221111050058, 830.3689196210893, 833.995830020852, 836.0343802907652, 836.2766207230732, 818.7380038387719, 823.5058964621239, 824.6083110522513, 824.9010118785724, 829.4484168028254, 602.1088788592863, 603.2670305578743, 603.414687752879, 606.5117580347818, 607.808540309801, 12475.625731228078, 12511.249325040435, 12542.937285313606, 12627.368631568384, 12632.0, 12695.492180312776, 13054.34728263583, 13073.0, 13078.215307081606, 13159.210447373189, 10342.689719308433, 10617.893821061845, 10749.570017199303, 10834.566617335297, 10940.945295273552, 3355.8489867956, 3379.3241351729753, 3380.7295416366633, 3401.200717831308, 3486.3724529584665, 43226.56773432257, 43867.78066109649, 45995.77002114968, 56995.71502142504, 57457.712711436594, 10112.393256404639, 10273.74315642115, 10290.434026128634, 10295.176385889112, 10490.790184196274, 17230.483085507203, 18185.63628727418, 18253.26986920535, 18264.086795660165, 18288.17703203359, 7133.928660713326, 7276.96361518189, 7325.084364454443, 7396.815079622945, 7576.204498527685, 3898.688104951597, 3990.5610382857863, 4022.1955608878343, 4101.753894766323, 4106.445629839934, 2970.8068975516953, 3052.435299469561, 3067.2331917020747, 3069.6009518762417, 3069.6623371429123, 522.9267902493654, 526.3683579704293, 537.6908277740315, 542.1731858915186, 543.6330476928058, 547.2420697334142, 624.6938999890112, 630.700417301778, 644.1207751419372, 659.577870163096, 7736.458447908705, 8111.594420278962, 8180.795480112925, 8406.905779188075, 8556.315494760403, 590.7312172961292, 617.5646169450616, 628.4281304013326, 656.4026735670517, 656.4387448731361, 3875.9418608720894, 4106.2198182345255, 4161.188568229166, 4252.107057517956, 4264.936025959613, 88684.5565772167, 94026.52986735023, 96998.51500742593, 97524.51237743908, 98166.50916745371, 81364.0, 81681.59159204285, 82483.58758206171, 82815.58592207122, 82942.0, 43070.7846460772, 43137.35293970593, 43915.0, 52064.739676301375, 73275.63362183048, 7583.27958843909, 7881.645325960231, 7955.1249362568915, 8003.19968003195, 8185.754427367188, 42681.57318426776, 43784.56215437805, 43784.78107609441, 44206.0, 44510.0, 55765.442345576026, 56146.71926640341, 58838.0, 62601.68699156475, 64063.35936640574, 10230.846537301797, 10366.533505992098, 10929.508172132431, 11461.541538338706, 11467.541298347973, 13235.0, 13438.865611344152, 13549.525766598123, 13550.322483875963, 14205.573832785032, 12156.513739450676, 12721.681957950756, 12734.936325318315, 13777.724445511234, 13830.662656911687, 12316.81524777147, 12579.308138052495, 12595.433205505591, 12781.872181278068, 13056.34718264064, 11310.705948523408, 11328.32030078198, 11354.489047992694, 11461.255018423775, 11468.655940321803, 10055.648052318134, 10082.243831712503, 10251.846222306522, 10634.41510716887, 10913.890861091288, 9742.219927313192, 10746.946265268936, 10754.892451075702, 10833.458327083772, 10903.672889813319], "value": 6563.535069750236, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 107.0, 117.0, 113.0, 116.0, 116.0, 114.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 138.0, 156.0, 180.0, 133.0, 160.0, 162.0, 137.0, 190.0, 142.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 173.0, 163.0, 161.0, 163.0, 163.0, 164.0, 163.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 166.0, 79.0, 76.0, 77.0, 75.0, 168.0, 80.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 142.0, 86.0, 86.0, 88.0, 131.0, 87.0, 88.0, 134.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 86.0, 91.0, 84.0, 83.0, 86.0, 100.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 131.0, 151.0, 130.0, 134.0, 140.0, 149.0, 131.0, 132.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 174.0, 171.0, 173.0, 175.0, 174.0, 171.0, 166.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 69.0, 69.0, 68.0, 66.0, 70.0, 68.0, 66.0], "value": 67.9, "unit": "score"}]}]} 05:08:08 INFO - Return code: 0 05:08:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:08:08 ERROR - # TBPL SUCCESS # 05:08:08 INFO - Running post-action listener: _resource_record_post_action 05:08:08 INFO - ##### 05:08:08 INFO - ##### Finished run-tests step (success) 05:08:08 INFO - ##### 05:08:08 INFO - Running post-run listener: _resource_record_post_run 05:08:09 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552570880; Read time: 12; Write time: 503404 05:08:09 INFO - TinderboxPrint: CPU usage
13.5% 05:08:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:08:09 INFO - TinderboxPrint: I/O write bytes / time
552,570,880 / 503,404 05:08:09 INFO - TinderboxPrint: CPU idle
8,272.5 (86.5%) 05:08:09 INFO - TinderboxPrint: CPU user
1,235.6 (12.9%) 05:08:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:08:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 257961984; Read time: 0; Write time: 262780 05:08:09 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294608896; Read time: 12; Write time: 240624 05:08:09 INFO - Running post-run listener: _upload_blobber_files 05:08:09 INFO - Blob upload gear active. 05:08:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08:09 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 05:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:08:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:14 INFO - (blobuploader) - INFO - Done attempting. 05:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:08:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:15 INFO - (blobuploader) - INFO - Done attempting. 05:08:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:08:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:16 INFO - (blobuploader) - INFO - Done attempting. 05:08:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:08:16 INFO - Return code: 0 05:08:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73338beac2100f677c4215921310dafce40ce73b9b1ec702f8ab0383f50a731fdc8f636e5d95b7259c21161f1fb5937257657d10ae2d88692910dbefac896bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fea8ce6265e073ca30ab7e8e041e4fa5419ce263bb4ee20c64a765459d10f501d83fea673977da673dc3597f6ffce8e0861ac61b2898c5c72eb362df2fab40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3feb8658cd6a86750797d200e8539a10144d06eada16b9700d6be0d2a9b7e1274a53ca9bbbcd1d06e6d547a1290a7e3f0181b4640156c076d37c43fb7a7468aa"} 05:08:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:16 INFO - Contents: 05:08:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73338beac2100f677c4215921310dafce40ce73b9b1ec702f8ab0383f50a731fdc8f636e5d95b7259c21161f1fb5937257657d10ae2d88692910dbefac896bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fea8ce6265e073ca30ab7e8e041e4fa5419ce263bb4ee20c64a765459d10f501d83fea673977da673dc3597f6ffce8e0861ac61b2898c5c72eb362df2fab40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3feb8658cd6a86750797d200e8539a10144d06eada16b9700d6be0d2a9b7e1274a53ca9bbbcd1d06e6d547a1290a7e3f0181b4640156c076d37c43fb7a7468aa"} 05:08:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:16 INFO - Copying logs to upload dir... 05:08:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.681489 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-23 05:08:16.534580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:08:16.538535) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73338beac2100f677c4215921310dafce40ce73b9b1ec702f8ab0383f50a731fdc8f636e5d95b7259c21161f1fb5937257657d10ae2d88692910dbefac896bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fea8ce6265e073ca30ab7e8e041e4fa5419ce263bb4ee20c64a765459d10f501d83fea673977da673dc3597f6ffce8e0861ac61b2898c5c72eb362df2fab40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3feb8658cd6a86750797d200e8539a10144d06eada16b9700d6be0d2a9b7e1274a53ca9bbbcd1d06e6d547a1290a7e3f0181b4640156c076d37c43fb7a7468aa"} build_url:https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73338beac2100f677c4215921310dafce40ce73b9b1ec702f8ab0383f50a731fdc8f636e5d95b7259c21161f1fb5937257657d10ae2d88692910dbefac896bd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fea8ce6265e073ca30ab7e8e041e4fa5419ce263bb4ee20c64a765459d10f501d83fea673977da673dc3597f6ffce8e0861ac61b2898c5c72eb362df2fab40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3feb8658cd6a86750797d200e8539a10144d06eada16b9700d6be0d2a9b7e1274a53ca9bbbcd1d06e6d547a1290a7e3f0181b4640156c076d37c43fb7a7468aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:08:16.567255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:08:16.567850) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466682452.354643-614576297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:08:16.653564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:08:16.654290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:08:16.654881) ========= ========= Total master_lag: 0.20 =========