builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465313188.01 results: success (0) buildid: 20160607053456 builduid: d3833be84c8d4486a7e37de4eaed1379 revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.014191) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.014699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.014983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.029839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.030148) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 08:26:29-- 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% 27.0M=0s 2016-06-07 08:26:29 (27.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.141236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.141562) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.191295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.191665) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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 d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 08:26:29,213 truncating revision to first 12 chars 2016-06-07 08:26:29,213 Setting DEBUG logging. 2016-06-07 08:26:29,213 attempt 1/10 2016-06-07 08:26:29,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6e0d9a0319f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 08:26:29,527 unpacking tar archive at: fx-team-d6e0d9a0319f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.869620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.869941) ========= script_repo_revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.870333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.870623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:28.878717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-07 08:26:28.879050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:26:29 INFO - MultiFileLogger online at 20160607 08:26:29 in /builds/slave/test 08:26:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:26:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:29 INFO - {'append_to_log': False, 08:26:29 INFO - 'base_work_dir': '/builds/slave/test', 08:26:29 INFO - 'blob_upload_branch': 'Fx-Team', 08:26:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:29 INFO - 'branch': 'Fx-Team', 08:26:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:29 INFO - 'config_files': ('talos/linux_config.py',), 08:26:29 INFO - 'default_actions': ('clobber', 08:26:29 INFO - 'read-buildbot-config', 08:26:29 INFO - 'download-and-extract', 08:26:29 INFO - 'populate-webroot', 08:26:29 INFO - 'create-virtualenv', 08:26:29 INFO - 'install', 08:26:29 INFO - 'run-tests'), 08:26:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:29 INFO - 'download_minidump_stackwalk': True, 08:26:29 INFO - 'download_symbols': 'ondemand', 08:26:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:29 INFO - 'installer_path': 'installer.exe', 08:26:29 INFO - 'log_level': 'info', 08:26:29 INFO - 'log_name': 'talos', 08:26:29 INFO - 'log_to_console': True, 08:26:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:26:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:26:29 INFO - 'opt_config_files': (), 08:26:29 INFO - 'pip_index': False, 08:26:29 INFO - 'sps_profile': False, 08:26:29 INFO - 'sps_profile_interval': 0, 08:26:29 INFO - 'suite': 'dromaeojs', 08:26:29 INFO - 'system_bits': '32', 08:26:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:29 INFO - 'title': 'talos-linux64-ix-019', 08:26:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:29 INFO - 'use_talos_json': True, 08:26:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:29 INFO - 'work_dir': 'build'} 08:26:29 INFO - ##### 08:26:29 INFO - ##### Running clobber step. 08:26:29 INFO - ##### 08:26:29 INFO - Running pre-action listener: _resource_record_pre_action 08:26:29 INFO - Running main action method: clobber 08:26:29 INFO - rmtree: /builds/slave/test/build 08:26:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:30 INFO - Running post-action listener: _resource_record_post_action 08:26:30 INFO - ##### 08:26:30 INFO - ##### Finished clobber step (success) 08:26:30 INFO - ##### 08:26:30 INFO - ##### 08:26:30 INFO - ##### Running read-buildbot-config step. 08:26:30 INFO - ##### 08:26:30 INFO - Running pre-action listener: _resource_record_pre_action 08:26:30 INFO - Running main action method: read_buildbot_config 08:26:30 INFO - Using buildbot properties: 08:26:30 INFO - { 08:26:30 INFO - "project": "", 08:26:30 INFO - "product": "firefox", 08:26:30 INFO - "script_repo_revision": "production", 08:26:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:26:30 INFO - "repository": "", 08:26:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:26:30 INFO - "buildid": "20160607053456", 08:26:30 INFO - "pgo_build": "True", 08:26:30 INFO - "basedir": "/builds/slave/test", 08:26:30 INFO - "buildnumber": 774, 08:26:30 INFO - "slavename": "talos-linux64-ix-019", 08:26:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:26:30 INFO - "platform": "ubuntu64_hw", 08:26:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:26:30 INFO - "branch": "fx-team", 08:26:30 INFO - "repo_path": "integration/fx-team", 08:26:30 INFO - "revision": "d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079", 08:26:30 INFO - "stage_platform": "linux64-pgo", 08:26:30 INFO - "builduid": "d3833be84c8d4486a7e37de4eaed1379", 08:26:30 INFO - "slavebuilddir": "test" 08:26:30 INFO - } 08:26:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:26:30 INFO - Running post-action listener: _resource_record_post_action 08:26:30 INFO - ##### 08:26:30 INFO - ##### Finished read-buildbot-config step (success) 08:26:30 INFO - ##### 08:26:30 INFO - ##### 08:26:30 INFO - ##### Running download-and-extract step. 08:26:30 INFO - ##### 08:26:30 INFO - Running pre-action listener: _resource_record_pre_action 08:26:30 INFO - Running main action method: download_and_extract 08:26:30 INFO - mkdir: /builds/slave/test/build/tests 08:26:30 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')]} 08:26:30 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:26:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:31 INFO - Downloaded 1361 bytes. 08:26:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:31 INFO - Using the following test package requirements: 08:26:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:26:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:26:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'jsshell-linux-x86_64.zip'], 08:26:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:26:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:26:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:26:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:26:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:26:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:31 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:32 INFO - Downloaded 24443862 bytes. 08:26:32 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'] 08:26:32 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 08:26:33 INFO - Return code: 0 08:26:33 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 08:26:33 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')]} 08:26:33 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:34 INFO - Downloaded 24443862 bytes. 08:26:34 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'] 08:26:34 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 08:26:36 INFO - Return code: 0 08:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:36 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:37 INFO - Downloaded 10833369 bytes. 08:26:37 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'] 08:26:37 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 08:26:37 INFO - Return code: 0 08:26:37 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')]} 08:26:37 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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 08:26:39 INFO - Downloaded 59185931 bytes. 08:26:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:39 INFO - mkdir: /builds/slave/test/properties 08:26:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:39 INFO - Contents: 08:26:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:40 INFO - Running post-action listener: _resource_record_post_action 08:26:40 INFO - Running post-action listener: set_extra_try_arguments 08:26:40 INFO - ##### 08:26:40 INFO - ##### Finished download-and-extract step (success) 08:26:40 INFO - ##### 08:26:40 INFO - ##### 08:26:40 INFO - ##### Running populate-webroot step. 08:26:40 INFO - ##### 08:26:40 INFO - Running pre-action listener: _resource_record_pre_action 08:26:40 INFO - Running main action method: populate_webroot 08:26:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:40 INFO - '--tppagecycles', 08:26:40 INFO - '7'], 08:26:40 INFO - 'tests': ['tsvgm']}}, 08:26:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['damp', 'tps']}, 08:26:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['damp', 'tps']}, 08:26:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['dromaeo_dom']}, 08:26:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tsvgx', 08:26:40 INFO - 'tsvgr_opacity', 08:26:40 INFO - 'tart', 08:26:40 INFO - 'tscrollx', 08:26:40 INFO - 'cart']}, 08:26:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:40 INFO - 'tsvgr_opacity', 08:26:40 INFO - 'tart', 08:26:40 INFO - 'tscrollx', 08:26:40 INFO - 'cart']}, 08:26:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tp5o']}, 08:26:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['tp5o']}, 08:26:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s', 08:26:40 INFO - '--xperf_path', 08:26:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:40 INFO - 'tests': ['tp5n']}, 08:26:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--xperf_path', 08:26:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:40 INFO - 'tests': ['tp5n']}}, 08:26:40 INFO - 'talos.zip': {'path': '', 08:26:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:40 INFO - Running post-action listener: _resource_record_post_action 08:26:40 INFO - ##### 08:26:40 INFO - ##### Finished populate-webroot step (success) 08:26:40 INFO - ##### 08:26:40 INFO - ##### 08:26:40 INFO - ##### Running create-virtualenv step. 08:26:40 INFO - ##### 08:26:40 INFO - Running pre-action listener: _resource_record_pre_action 08:26:40 INFO - Running main action method: create_virtualenv 08:26:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:40 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 08:26:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:40 INFO - Using real prefix '/usr' 08:26:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:42 INFO - Installing pip.................done. 08:26:42 INFO - Return code: 0 08:26:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:42 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:42 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 08:26:42 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 08:26:42 INFO - Using env: {'DISPLAY': ':0', 08:26:42 INFO - 'HOME': '/home/cltbld', 08:26:42 INFO - 'LANG': 'en_US.UTF-8', 08:26:42 INFO - 'LANGUAGE': 'en_US:en', 08:26:42 INFO - 'LOGNAME': 'cltbld', 08:26:42 INFO - 'MAIL': '/var/mail/cltbld', 08:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:42 INFO - 'MOZ_NO_REMOTE': '1', 08:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:42 INFO - 'NO_EM_RESTART': '1', 08:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:42 INFO - 'PWD': '/builds/slave/test', 08:26:42 INFO - 'SHELL': '/bin/bash', 08:26:42 INFO - 'SHLVL': '1', 08:26:42 INFO - 'TERM': 'linux', 08:26:42 INFO - 'TMOUT': '86400', 08:26:42 INFO - 'USER': 'cltbld', 08:26:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:42 INFO - '_': '/tools/buildbot/bin/python'} 08:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:42 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 08:26:42 INFO - Cleaning up... 08:26:42 INFO - Return code: 0 08:26:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:42 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:42 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 08:26:42 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 08:26:42 INFO - Using env: {'DISPLAY': ':0', 08:26:42 INFO - 'HOME': '/home/cltbld', 08:26:42 INFO - 'LANG': 'en_US.UTF-8', 08:26:42 INFO - 'LANGUAGE': 'en_US:en', 08:26:42 INFO - 'LOGNAME': 'cltbld', 08:26:42 INFO - 'MAIL': '/var/mail/cltbld', 08:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:42 INFO - 'MOZ_NO_REMOTE': '1', 08:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:42 INFO - 'NO_EM_RESTART': '1', 08:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:42 INFO - 'PWD': '/builds/slave/test', 08:26:42 INFO - 'SHELL': '/bin/bash', 08:26:42 INFO - 'SHLVL': '1', 08:26:42 INFO - 'TERM': 'linux', 08:26:42 INFO - 'TMOUT': '86400', 08:26:42 INFO - 'USER': 'cltbld', 08:26:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:42 INFO - '_': '/tools/buildbot/bin/python'} 08:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:43 INFO - Downloading/unpacking psutil>=3.1.1 08:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:45 INFO - Installing collected packages: psutil 08:26:45 INFO - Running setup.py install for psutil 08:26:45 INFO - building 'psutil._psutil_linux' extension 08:26:45 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 08:26:45 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 08:26:45 INFO - building 'psutil._psutil_posix' extension 08:26:45 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 08:26:45 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 08:26:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:45 INFO - Successfully installed psutil 08:26:45 INFO - Cleaning up... 08:26:45 INFO - Return code: 0 08:26:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:45 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:45 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 08:26:45 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 08:26:45 INFO - Using env: {'DISPLAY': ':0', 08:26:45 INFO - 'HOME': '/home/cltbld', 08:26:45 INFO - 'LANG': 'en_US.UTF-8', 08:26:45 INFO - 'LANGUAGE': 'en_US:en', 08:26:45 INFO - 'LOGNAME': 'cltbld', 08:26:45 INFO - 'MAIL': '/var/mail/cltbld', 08:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:45 INFO - 'MOZ_NO_REMOTE': '1', 08:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:45 INFO - 'NO_EM_RESTART': '1', 08:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:45 INFO - 'PWD': '/builds/slave/test', 08:26:45 INFO - 'SHELL': '/bin/bash', 08:26:45 INFO - 'SHLVL': '1', 08:26:45 INFO - 'TERM': 'linux', 08:26:45 INFO - 'TMOUT': '86400', 08:26:45 INFO - 'USER': 'cltbld', 08:26:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:45 INFO - '_': '/tools/buildbot/bin/python'} 08:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:45 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 08:26:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:47 INFO - Installing collected packages: mozsystemmonitor 08:26:47 INFO - Running setup.py install for mozsystemmonitor 08:26:47 INFO - Successfully installed mozsystemmonitor 08:26:48 INFO - Cleaning up... 08:26:48 INFO - Return code: 0 08:26:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:48 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 08:26:48 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 08:26:48 INFO - Using env: {'DISPLAY': ':0', 08:26:48 INFO - 'HOME': '/home/cltbld', 08:26:48 INFO - 'LANG': 'en_US.UTF-8', 08:26:48 INFO - 'LANGUAGE': 'en_US:en', 08:26:48 INFO - 'LOGNAME': 'cltbld', 08:26:48 INFO - 'MAIL': '/var/mail/cltbld', 08:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:48 INFO - 'MOZ_NO_REMOTE': '1', 08:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:48 INFO - 'NO_EM_RESTART': '1', 08:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:48 INFO - 'PWD': '/builds/slave/test', 08:26:48 INFO - 'SHELL': '/bin/bash', 08:26:48 INFO - 'SHLVL': '1', 08:26:48 INFO - 'TERM': 'linux', 08:26:48 INFO - 'TMOUT': '86400', 08:26:48 INFO - 'USER': 'cltbld', 08:26:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:48 INFO - '_': '/tools/buildbot/bin/python'} 08:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:50 INFO - warning: no files found matching '*.txt' 08:26:50 INFO - no previously-included directories found matching 'build' 08:26:50 INFO - no previously-included directories found matching 'dist' 08:26:50 INFO - no previously-included directories found matching '.git*' 08:26:50 INFO - Installing collected packages: jsonschema, functools32 08:26:50 INFO - Running setup.py install for functools32 08:26:50 INFO - warning: no files found matching '*.txt' 08:26:50 INFO - no previously-included directories found matching 'build' 08:26:50 INFO - no previously-included directories found matching 'dist' 08:26:50 INFO - no previously-included directories found matching '.git*' 08:26:50 INFO - Successfully installed jsonschema functools32 08:26:50 INFO - Cleaning up... 08:26:50 INFO - Return code: 0 08:26:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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', '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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:26: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 blobuploader==1.2.4 08:26:50 INFO - Using env: {'DISPLAY': ':0', 08:26:50 INFO - 'HOME': '/home/cltbld', 08:26:50 INFO - 'LANG': 'en_US.UTF-8', 08:26:50 INFO - 'LANGUAGE': 'en_US:en', 08:26:50 INFO - 'LOGNAME': 'cltbld', 08:26:50 INFO - 'MAIL': '/var/mail/cltbld', 08:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:50 INFO - 'MOZ_NO_REMOTE': '1', 08:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:50 INFO - 'NO_EM_RESTART': '1', 08:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:50 INFO - 'PWD': '/builds/slave/test', 08:26:50 INFO - 'SHELL': '/bin/bash', 08:26:50 INFO - 'SHLVL': '1', 08:26:50 INFO - 'TERM': 'linux', 08:26:50 INFO - 'TMOUT': '86400', 08:26:50 INFO - 'USER': 'cltbld', 08:26:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:50 INFO - '_': '/tools/buildbot/bin/python'} 08:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:52 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 08:26:52 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 08:26:52 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 08:26:52 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 08:26:52 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 08:26:52 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 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:53 INFO - Downloading docopt-0.6.1.tar.gz 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:53 INFO - Running setup.py install for blobuploader 08:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:53 INFO - Running setup.py install for requests 08:26:53 INFO - Running setup.py install for docopt 08:26:54 INFO - Successfully installed blobuploader requests docopt 08:26:54 INFO - Cleaning up... 08:26:54 INFO - Return code: 0 08:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:54 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 08:26:54 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 08:26:54 INFO - Using env: {'DISPLAY': ':0', 08:26:54 INFO - 'HOME': '/home/cltbld', 08:26:54 INFO - 'LANG': 'en_US.UTF-8', 08:26:54 INFO - 'LANGUAGE': 'en_US:en', 08:26:54 INFO - 'LOGNAME': 'cltbld', 08:26:54 INFO - 'MAIL': '/var/mail/cltbld', 08:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:54 INFO - 'MOZ_NO_REMOTE': '1', 08:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:54 INFO - 'NO_EM_RESTART': '1', 08:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:54 INFO - 'PWD': '/builds/slave/test', 08:26:54 INFO - 'SHELL': '/bin/bash', 08:26:54 INFO - 'SHLVL': '1', 08:26:54 INFO - 'TERM': 'linux', 08:26:54 INFO - 'TMOUT': '86400', 08:26:54 INFO - 'USER': 'cltbld', 08:26:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:54 INFO - '_': '/tools/buildbot/bin/python'} 08:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:54 INFO - Running setup.py (path:/tmp/pip-GTMIBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:54 INFO - Running setup.py (path:/tmp/pip-7qaaJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:54 INFO - Running setup.py (path:/tmp/pip-P8FcLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:54 INFO - Running setup.py (path:/tmp/pip-T2Jn3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:54 INFO - Running setup.py (path:/tmp/pip-Z5QNmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:54 INFO - Running setup.py (path:/tmp/pip-iGR253-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:54 INFO - Running setup.py (path:/tmp/pip-1kN4UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:54 INFO - Running setup.py (path:/tmp/pip-rtTGLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:54 INFO - Running setup.py (path:/tmp/pip-7f7Q4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:54 INFO - Running setup.py (path:/tmp/pip-LlcEM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:55 INFO - Running setup.py (path:/tmp/pip-Vq3sLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:55 INFO - Running setup.py (path:/tmp/pip-2sdp8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:55 INFO - Running setup.py (path:/tmp/pip-TYDXOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:55 INFO - Running setup.py (path:/tmp/pip-cujshs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:55 INFO - Running setup.py (path:/tmp/pip-3kw_6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:55 INFO - Running setup.py (path:/tmp/pip-P8rKll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:55 INFO - Running setup.py (path:/tmp/pip-oXCcpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:55 INFO - Running setup.py install for manifestparser 08:26:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:55 INFO - Running setup.py install for mozcrash 08:26:55 INFO - Running setup.py install for mozdebug 08:26:55 INFO - Running setup.py install for mozdevice 08:26:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:55 INFO - Running setup.py install for mozfile 08:26:56 INFO - Running setup.py install for mozhttpd 08:26:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozinfo 08:26:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozInstall 08:26:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozleak 08:26:56 INFO - Running setup.py install for mozlog 08:26:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for moznetwork 08:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozprocess 08:26:56 INFO - Running setup.py install for mozprofile 08:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozrunner 08:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Running setup.py install for mozscreenshot 08:26:57 INFO - Running setup.py install for moztest 08:26:57 INFO - Running setup.py install for mozversion 08:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:57 INFO - Cleaning up... 08:26:57 INFO - Return code: 0 08:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:57 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:26:57 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 08:26:57 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 08:26:57 INFO - Using env: {'DISPLAY': ':0', 08:26:57 INFO - 'HOME': '/home/cltbld', 08:26:57 INFO - 'LANG': 'en_US.UTF-8', 08:26:57 INFO - 'LANGUAGE': 'en_US:en', 08:26:57 INFO - 'LOGNAME': 'cltbld', 08:26:57 INFO - 'MAIL': '/var/mail/cltbld', 08:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:57 INFO - 'MOZ_NO_REMOTE': '1', 08:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:57 INFO - 'NO_EM_RESTART': '1', 08:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:57 INFO - 'PWD': '/builds/slave/test', 08:26:57 INFO - 'SHELL': '/bin/bash', 08:26:57 INFO - 'SHLVL': '1', 08:26:57 INFO - 'TERM': 'linux', 08:26:57 INFO - 'TMOUT': '86400', 08:26:57 INFO - 'USER': 'cltbld', 08:26:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:57 INFO - '_': '/tools/buildbot/bin/python'} 08:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:57 INFO - Running setup.py (path:/tmp/pip-9hRc6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:57 INFO - Running setup.py (path:/tmp/pip-45O356-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:57 INFO - Running setup.py (path:/tmp/pip-zCCSB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:57 INFO - Running setup.py (path:/tmp/pip-cNHf0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:57 INFO - Running setup.py (path:/tmp/pip-MY71WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:57 INFO - Running setup.py (path:/tmp/pip-OR3rUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:57 INFO - Running setup.py (path:/tmp/pip-vOtxdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:58 INFO - Running setup.py (path:/tmp/pip-pHROVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:58 INFO - Running setup.py (path:/tmp/pip-odFYjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:58 INFO - Running setup.py (path:/tmp/pip-y_DHOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:58 INFO - Running setup.py (path:/tmp/pip-JMV01c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:58 INFO - Running setup.py (path:/tmp/pip-cPNw9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:58 INFO - Running setup.py (path:/tmp/pip-NYvP2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:58 INFO - Running setup.py (path:/tmp/pip-4VMzze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:58 INFO - Running setup.py (path:/tmp/pip-MAq5vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:58 INFO - Running setup.py (path:/tmp/pip-Up7svM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:58 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)) 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:58 INFO - Running setup.py (path:/tmp/pip-0eF8oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:58 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)) 08:26:58 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)) 08:26:58 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)) 08:26:58 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)) 08:26:58 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)) 08:26:58 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)) 08:26:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:27:00 INFO - Downloading blessings-1.6.tar.gz 08:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:00 INFO - Installing collected packages: blessings 08:27:00 INFO - Running setup.py install for blessings 08:27:00 INFO - Successfully installed blessings 08:27:00 INFO - Cleaning up... 08:27:00 INFO - Return code: 0 08:27:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:01 INFO - Reading from file tmpfile_stdout 08:27:01 INFO - Current package versions: 08:27:01 INFO - argparse == 1.2.1 08:27:01 INFO - blessings == 1.6 08:27:01 INFO - blobuploader == 1.2.4 08:27:01 INFO - docopt == 0.6.1 08:27:01 INFO - functools32 == 3.2.3-2 08:27:01 INFO - jsonschema == 2.5.1 08:27:01 INFO - manifestparser == 1.1 08:27:01 INFO - mozInstall == 1.12 08:27:01 INFO - mozcrash == 0.17 08:27:01 INFO - mozdebug == 0.1 08:27:01 INFO - mozdevice == 0.48 08:27:01 INFO - mozfile == 1.2 08:27:01 INFO - mozhttpd == 0.7 08:27:01 INFO - mozinfo == 0.9 08:27:01 INFO - mozleak == 0.1 08:27:01 INFO - mozlog == 3.2 08:27:01 INFO - moznetwork == 0.27 08:27:01 INFO - mozprocess == 0.22 08:27:01 INFO - mozprofile == 0.28 08:27:01 INFO - mozrunner == 6.11 08:27:01 INFO - mozscreenshot == 0.1 08:27:01 INFO - mozsystemmonitor == 0.3 08:27:01 INFO - moztest == 0.7 08:27:01 INFO - mozversion == 1.4 08:27:01 INFO - psutil == 3.1.1 08:27:01 INFO - requests == 1.2.3 08:27:01 INFO - wsgiref == 0.1.2 08:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:27:01 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 08:27:01 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 08:27:01 INFO - Using env: {'DISPLAY': ':0', 08:27:01 INFO - 'HOME': '/home/cltbld', 08:27:01 INFO - 'LANG': 'en_US.UTF-8', 08:27:01 INFO - 'LANGUAGE': 'en_US:en', 08:27:01 INFO - 'LOGNAME': 'cltbld', 08:27:01 INFO - 'MAIL': '/var/mail/cltbld', 08:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:01 INFO - 'MOZ_NO_REMOTE': '1', 08:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:01 INFO - 'NO_EM_RESTART': '1', 08:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:01 INFO - 'PWD': '/builds/slave/test', 08:27:01 INFO - 'SHELL': '/bin/bash', 08:27:01 INFO - 'SHLVL': '1', 08:27:01 INFO - 'TERM': 'linux', 08:27:01 INFO - 'TMOUT': '86400', 08:27:01 INFO - 'USER': 'cltbld', 08:27:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:01 INFO - '_': '/tools/buildbot/bin/python'} 08:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 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)) 08:27:01 INFO - Cleaning up... 08:27:01 INFO - Return code: 0 08:27:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:27:01 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 08:27:01 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 08:27:01 INFO - Using env: {'DISPLAY': ':0', 08:27:01 INFO - 'HOME': '/home/cltbld', 08:27:01 INFO - 'LANG': 'en_US.UTF-8', 08:27:01 INFO - 'LANGUAGE': 'en_US:en', 08:27:01 INFO - 'LOGNAME': 'cltbld', 08:27:01 INFO - 'MAIL': '/var/mail/cltbld', 08:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:01 INFO - 'MOZ_NO_REMOTE': '1', 08:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:01 INFO - 'NO_EM_RESTART': '1', 08:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:01 INFO - 'PWD': '/builds/slave/test', 08:27:01 INFO - 'SHELL': '/bin/bash', 08:27:01 INFO - 'SHLVL': '1', 08:27:01 INFO - 'TERM': 'linux', 08:27:01 INFO - 'TMOUT': '86400', 08:27:01 INFO - 'USER': 'cltbld', 08:27:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:01 INFO - '_': '/tools/buildbot/bin/python'} 08:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:01 INFO - Cleaning up... 08:27:01 INFO - Return code: 0 08:27:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 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 0x7fd306e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', '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 08:27:01 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 08:27:01 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 08:27:01 INFO - Using env: {'DISPLAY': ':0', 08:27:01 INFO - 'HOME': '/home/cltbld', 08:27:01 INFO - 'LANG': 'en_US.UTF-8', 08:27:01 INFO - 'LANGUAGE': 'en_US:en', 08:27:01 INFO - 'LOGNAME': 'cltbld', 08:27:01 INFO - 'MAIL': '/var/mail/cltbld', 08:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:01 INFO - 'MOZ_NO_REMOTE': '1', 08:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:01 INFO - 'NO_EM_RESTART': '1', 08:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:01 INFO - 'PWD': '/builds/slave/test', 08:27:01 INFO - 'SHELL': '/bin/bash', 08:27:01 INFO - 'SHLVL': '1', 08:27:01 INFO - 'TERM': 'linux', 08:27:01 INFO - 'TMOUT': '86400', 08:27:01 INFO - 'USER': 'cltbld', 08:27:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:01 INFO - '_': '/tools/buildbot/bin/python'} 08:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:01 INFO - Downloading/unpacking flake8 08:27:01 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 08:27:01 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 08:27:01 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 08:27:01 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 08:27:01 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 08:27:01 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 08:27:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:27:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:27:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27: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 08:27:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:27:04 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 08:27:04 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 08:27:04 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 08:27:04 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 08:27:04 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 08:27:04 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 08:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:27:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:27:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:27:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:27:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:27:04 INFO - no previously-included directories found matching 'docs/_build' 08:27:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:27:04 INFO - Running setup.py install for pep8 08:27:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:27:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:27:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:27:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:27:04 INFO - no previously-included directories found matching 'docs/_build' 08:27:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:27:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:27:04 INFO - Cleaning up... 08:27:04 INFO - Return code: 0 08:27:04 INFO - Running post-action listener: _resource_record_post_action 08:27:04 INFO - Running post-action listener: _start_resource_monitoring 08:27:04 INFO - Starting resource monitoring. 08:27:04 INFO - ##### 08:27:04 INFO - ##### Finished create-virtualenv step (success) 08:27:04 INFO - ##### 08:27:04 INFO - ##### 08:27:04 INFO - ##### Running install step. 08:27:04 INFO - ##### 08:27:04 INFO - Running pre-action listener: _resource_record_pre_action 08:27:04 INFO - Running main action method: install 08:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:04 INFO - Reading from file tmpfile_stdout 08:27:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:04 INFO - Reading from file tmpfile_stdout 08:27:04 INFO - Output received: 08:27:04 INFO - Usage: mozinstall [options] installer 08:27:04 INFO - Options: 08:27:04 INFO - -h, --help show this help message and exit 08:27:04 INFO - -d DEST, --destination=DEST 08:27:04 INFO - Directory to install application into. [default: 08:27:04 INFO - "/builds/slave/test"] 08:27:04 INFO - --app=APP Application being installed. [default: firefox] 08:27:04 INFO - mkdir: /builds/slave/test/build/application 08:27:04 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'] 08:27:04 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 08:27:21 INFO - Reading from file tmpfile_stdout 08:27:21 INFO - Output received: 08:27:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:27:21 INFO - Running post-action listener: _resource_record_post_action 08:27:21 INFO - ##### 08:27:21 INFO - ##### Finished install step (success) 08:27:21 INFO - ##### 08:27:21 INFO - ##### 08:27:21 INFO - ##### Running run-tests step. 08:27:21 INFO - ##### 08:27:21 INFO - Running pre-action listener: _resource_record_pre_action 08:27:21 INFO - Running main action method: run_tests 08:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:21 INFO - Python 2.7.3 08:27:21 INFO - Return code: 0 08:27:21 INFO - grabbing minidump binary from tooltool 08:27:21 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')]} 08:27:21 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 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:21 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 08:27:21 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 08:27:21 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 08:27:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:21 INFO - Return code: 0 08:27:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:27:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:27:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:27:22 INFO - Return code: 0 08:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:27:22 INFO - Using env: {'DISPLAY': ':0', 08:27:22 INFO - 'HOME': '/home/cltbld', 08:27:22 INFO - 'LANG': 'en_US.UTF-8', 08:27:22 INFO - 'LANGUAGE': 'en_US:en', 08:27:22 INFO - 'LOGNAME': 'cltbld', 08:27:22 INFO - 'MAIL': '/var/mail/cltbld', 08:27:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:22 INFO - 'MOZ_NO_REMOTE': '1', 08:27:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:22 INFO - 'NO_EM_RESTART': '1', 08:27:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:22 INFO - 'PWD': '/builds/slave/test', 08:27:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:22 INFO - 'SHELL': '/bin/bash', 08:27:22 INFO - 'SHLVL': '1', 08:27:22 INFO - 'TERM': 'linux', 08:27:22 INFO - 'TMOUT': '86400', 08:27:22 INFO - 'USER': 'cltbld', 08:27:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824', 08:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:22 INFO - '_': '/tools/buildbot/bin/python'} 08:27:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:27:22 INFO - mozversion application_buildid: 20160607053456 08:27:22 INFO - mozversion application_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 08:27:22 INFO - mozversion application_display_name: Nightly 08:27:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:22 INFO - mozversion application_name: Firefox 08:27:22 INFO - mozversion application_remotingname: firefox 08:27:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:27:22 INFO - mozversion application_vendor: Mozilla 08:27:22 INFO - mozversion application_version: 50.0a1 08:27:22 INFO - mozversion platform_buildid: 20160607053456 08:27:22 INFO - mozversion platform_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 08:27:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:27:22 INFO - mozversion platform_version: 50.0a1 08:27:22 INFO - using testdate: 1465313242 08:27:22 INFO - actual date: 1465313242 08:27:22 INFO - starting webserver on 'localhost:46198' 08:27:22 INFO - SUITE-START | Running 2 tests 08:27:22 INFO - TEST-START | dromaeo_css 08:27:22 INFO - operating with platform_type : linux_ 08:27:22 INFO - Initialising browser for dromaeo_css test... 08:27:22 INFO - TEST-INFO | started process 9613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIkjx0/profile http://localhost:46198/getInfo.html) 08:27:27 INFO - PROCESS | 9613 | __metrics Screen width/height:1600/1200 08:27:27 INFO - PROCESS | 9613 | colorDepth:24 08:27:27 INFO - PROCESS | 9613 | Browser inner width/height: 1024/697 08:27:27 INFO - PROCESS | 9613 | __metrics 08:27:28 ERROR - PROCESS | 9613 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:27:28 INFO - PROCESS | 9613 | console.error: PushService: 08:27:28 INFO - PROCESS | 9613 | stateChangeProcessEnqueue: Error transitioning state 08:27:28 INFO - PROCESS | 9613 | UnknownError 08:27:29 INFO - TEST-INFO | 9613: exit 0 08:27:29 INFO - Browser initialized. 08:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:29 INFO - TEST-INFO | started process 9696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIkjx0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:41 INFO - PROCESS | 9696 | RSS: Main: 155914240 08:27:41 INFO - PROCESS | 9696 | 08:28:32 INFO - PROCESS | 9696 | 1465313312337 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] 08:30:40 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46198/tests/dromaeo/cssquery-ext.html) 08:30:41 INFO - PROCESS | 9696 | RSS: Main: 258461696 08:30:41 INFO - PROCESS | 9696 | 08:33:43 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-ext.html (next: http://localhost:46198/tests/dromaeo/cssquery-jquery.html) 08:33:44 INFO - PROCESS | 9696 | RSS: Main: 246063104 08:33:44 INFO - PROCESS | 9696 | 08:36:46 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46198/tests/dromaeo/cssquery-mootools.html) 08:36:47 INFO - PROCESS | 9696 | RSS: Main: 244842496 08:36:47 INFO - PROCESS | 9696 | 08:39:49 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46198/tests/dromaeo/cssquery-prototype.html) 08:39:49 INFO - PROCESS | 9696 | RSS: Main: 243720192 08:39:49 INFO - PROCESS | 9696 | 08:42:52 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46198/tests/dromaeo/cssquery-yui.html) 08:42:52 INFO - PROCESS | 9696 | RSS: Main: 224673792 08:42:52 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | Cycle 1(1): loaded http://localhost:46198/tests/dromaeo/cssquery-yui.html (next: http://localhost:46198/tests/dromaeo/cssquery-dojo.html) 08:45:55 INFO - PROCESS | 9696 | RSS: Main: 269611008 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | __start_tp_report 08:45:55 INFO - PROCESS | 9696 | _x_x_mozilla_page_load 08:45:55 INFO - PROCESS | 9696 | _x_x_mozilla_page_load_details 08:45:55 INFO - PROCESS | 9696 | |i|pagename|runs| 08:45:55 INFO - PROCESS | 9696 | |0;dojo.html;3128.577642018327;3136.357046805405;3184.028871194285;3185.2036990752304;3230.160158358826;5339.733013349327;5404.4595540445935;5413.052715774734;5518.9724051379735;5533.584981126416;5446.128619420893;5461;5544.3346798384255;5564.4713752193575;5608.158776183574;4875.585575226101;4937.654364194508;4980.676256043345;4997.775100120485;5156.04613146569;5065;5082.695038297714;5116.616253780962;5135.6148288878485;5141.665791723544;4790;4932.186189278765;4937.185364414867;4941.209406494943;4978.726170060663;4920;4940.135476291671;5018.949810501885;5026.045051440215;5059.064073146443;4805.399325084364;4940.851774446736;4968.527989840995;4989.800407983676;5023.824166154203;5357.946420535784;5439.972800136014;5478.945210547883;5524.779008839641;5525.392206857243;5947.6431414115295;5969.522438204933;5990.460858522754;5999.220101386835;6003.489703375219;5730.570207234474;5823.213866128103;6004.519638428916;6037.849053773647;6048.243969503812;5465.398806131322;5540.667559946376;5582.497575218169;5587.944120558824;5591.804286849941;6044.1469977857205;6050.570153693604;6050.728227484377;6064.15731452978;6109.5112391008615;5676.829695109153;5752.827415177468;5781.595288329777;5865.472107510344;5871.647701137946;5907.409259074144;5932.288125424977;5938.346781853993;5986.850328741816;5994.610350327215;5869.266341707286;5870.26621672291;5915.733791979371;5918.852028699317;5952.255968003999;5663.235463212413;5747.712614369265;5812.360640329561;5827.562932780059;5937.2578427696535;4433.312836510346;4442.089371678798;4443.155800397914;4444.911101777946;4475.216837053503;3929.410588411761;3953.0710283083454;3979.7015223858325;4006.779627120478;4029.8388064477094;5432.158015507603;5486.341639003265;5520.282363292747;5575;5582.637128586629;5949.167116603679;5966.820995370146;5971.58198926071;5977.551683623658;6040.305364883006;5597.272354593958;5610.186522954149;5616.550675945915;5620.662760234399;5631.662100273997;4911.238757992517;5028.974855125701;5080.034793389244;5098.668586541863;5126.512981266774;6174.536909731788;6175.814725558151;6176.227971503562;6180.103884936659;6185.969070154621;5671.404502527175;5966.671833049224;5978.9402105980125;5979.162917191509;5980.581359304807;6005.699715014319;6065.514758819196;6092.390760923872;6102;6124.6325220486915;5789.652620842763;5810.477057064884;5811.535077193899;5820.679862607597;5824.504917081926;5647.830565083054;5831.446012628793;5900.055991041584;5924.170616113662;5925.259342582177;5771.59598828078;5809.564282678732;5814.127880817911;5817.563682723728;5868.413158684098;5782.5663075268685;5791.102379131242;5791.333996590278;5791.594588378773;5793.91309130355;5468.890622187613;5558.194061860927;5613.74738136793;5680.68756218412;5688.658680479184;5793.391693872251;5802.535797136304;5820.650760954187;5829.038208695518;5844.211031510862;5577.8047768327915;5589.469000444951;5595.832125036255;5635.323761148688;5685.857853553694 08:45:55 INFO - PROCESS | 9696 | |1;ext.html;583.9211706419635;601.0083362451953;611.0986295214557;620.9782657606984;627.9466245369143;33777;34593.13517162075;34865.651343486556;34880;42666;44459.77770111145;45082.54917450825;45096;45098.549014509845;45113.32330015044;8567.186117318844;8731.301495880314;8731.869021964676;8733.606987685569;8745.387822852403;8786.560671966408;8867.290616750644;8867.822643547126;8958.552072396387;8969.192772650493;8942.86585701215;8969.641214351419;8973.730788076367;8982.550872456351;8983.371164018521;8913.732588022338;8946.418482798663;8978.057303983052;8978.910210897873;8980.730578082603;8725.083866194022;8789.64841406343;8790.428622139605;8932.151445612657;8946.55267236642;42217.78891105525;42737.35893961593;42770.57229427697;42771.14457710859;42838;3631.509746184258;3682.097886017916;3749.2501499699897;3803.448499967517;3879.941800872989;31112.533312000338;33251.5012274816;33907.15232119217;33913;33930.49104263438;4427.623651989553;4476.261416866246;4526.615237704799;4532.9546704533195;4662.650301227422;375852;380504.0974795136;382886;383083.4379077782;384701.9999999972;64629;65294;65527.344726552124;65626.67186664036;65686;36114.63885361165;37048.406611536935;37139.25721485555;39189.608103918596;68801.65599172072;16205.432809851834;16381.918090409472;16382.75425868613;16418;16420.261088251056;12080.39598020113;12200.51197952072;12209.633710988684;12210.816837747441;12212.877871221173;20746.170153194005;20807.271745488837;20903.477413064797;20924.686129708065;20997.370078897657;7271.163816161104;7364.521306115085;7461.552306861606;7623.390128789683;7691.423143264277;955.9044095590385;1062.2988827373897;1140.937248451343;1209.4920133543933;1213.1568559850818;32753.83623081917;32970.50544241838;33005.66994330026;33361.332773344395;33364.499532507034;1124.5389390349917;1132.1904838040841;1195.2768575011992;1208.9335086570322;1214.1440284599337;17125.571860703334;17138;17344.826551734575;17425;17690.646187076185;541932;544860;547091;547115;548335;58105.70947145237;58622;58737.706311469025;58780.70609646924;58806.11790823141;1235.6849003504228;1349.3455673998103;1369.0963963783854;1381.9723605527834;1388.7014291927082;32218.516722248718;33965.83017084899;34117.147071323416;34138.65861341355;34310.48534272038;49328.75335623299;54502.7274863639;55574.72212638911;56134.157987631035;60901.39098609134;489189;489659;493322;494478;495483;37208.255834882606;44797.104057919314;46064.309035363825;46899;48212;48084;48228.794280141876;48428;48847.5115248843;49203;41775.37336940009;41866;42095.36856947087;42564.57435425606;43311.783441082596;41323;42141.78929105458;42350.15299693927;42428.57571424246;42496;41479;42033.57966420297;42416.151676965674;42543.5745642552;42663;34820.65179348174;37237.44143837791;37373;38470.80764596159;38745.4188187183;28446.57330140008;28627.14118576446;28708.282292942844;28870.566941496316;29015.85492072526 08:45:55 INFO - PROCESS | 9696 | |2;jquery.html;386.3291265277674;391.3112921258584;391.42656008946904;403.12722954802854;418.6274215947807;14298.714025719506;17989.460316190536;18401.447956561293;19668.213271469143;19830.60338793225;18139.45581632553;19169.32907348243;19381.903090484528;19671.803281967175;19746;5570.637908535952;5746.138079288098;5798.043322851724;5799.9130013049835;5802.187693722883;4028.415879697442;4282.892927676818;5568.1647752837;5680.744366503517;5752.079667253241;6029.457348838604;6410.1987251593555;6412.615243085406;6417.486601071926;6538.705758240891;6232.189815324002;6280.783875362422;6482.157319548475;6485.740570377179;6490.8052758417325;5614.101743721026;5717.399673034354;5737.39757325479;5738.081906894919;5772.30732312121;23025.654615180785;23420.297391078297;24562.263132105887;24606.138785142433;24638.13766518163;2492.962605560918;2539.771420572139;2557.6802899637546;2558.2069558436942;2663.8401695898115;14497;14548.70902581953;14616.415343386252;14797.556073317817;15342.309596068204;1927.5905118601747;2020.5655784006362;2043.4993426610577;2050.1184490669007;2081.5628717969244;79452;82519.17480825174;83032;83685.58157209175;83853.58073209594;10686.305390149615;10761.30051546647;10995.395253260987;11154.665360039211;11301.491432885376;13336.266505342106;14012.859871401359;14981;15527.068375897483;15534;7908.960455197687;7927.722529711433;8016.478928869605;8094.595270236465;8122.213113115105;7502.362299204519;7526.09686837583;7555.546667199986;7616.352610028099;7666.195049519832;6838.076859623887;6865.656717164122;6937.3062693731235;6950.79147625572;7006.334398232159;1851.1577232359514;1915.1669023974616;1925.9037048147536;1979.4655443030301;2013.748281464817;910.321810251367;993.3890657245886;1028.8199565076081;1051.1800795379615;1114.7714718482691;19135.90432047831;19399.515012124808;19529.218831246875;19711.310104146574;19779.30772422987;948.3835506920557;984.7833476635129;989.2827699917502;1012.5089331674133;1030.3560274828233;9692.95153524242;11045.226834121695;11081.889181108247;11118.777624447466;11123.110151187886;404725;405055;411584;412843;413215;90301.54849225843;91585.54207228922;92268.53865730629;94134.52932735429;95450;957.674390707163;958.3531116496476;975.1370037516849;980.8626792249091;1011.5043628622069;17273.749912894607;17374.739378909075;17593.912030439766;17634.206460709043;17777.644447110728;28507.42985140327;37488.43767343547;38396.6160338393;40615.18769624532;40670.79664601658;55471.722641386536;56773.41245819634;57540;57623;58230.4176958225;6324.367563243639;6404.327545607644;6428.935710643021;6429.646369449725;6538.967305163634;11887.76224475523;12805.359732013549;12919.22484650924;12945.676358091123;12998.155119917175;11069.612563560559;11434.485448154686;11523.366214858263;11743.70997655449;12164.2701437914;11475.770484590428;11595.536178552764;11770.529178833094;11853.170278080452;12156.93921530422;11392.373419462008;11594.420278986187;11664.475098620413;11731.41342932833;11963.76072478563;6406.647634379968;6453.322401147811;6482.70827812759;6484.610923344614;6639.435647969976;9627.855582166414;11353.772924541629;11495.310281383145;11819;12143.149979501704 08:45:55 INFO - PROCESS | 9696 | |3;mootools.html;1340.3700260877383;1448.898577099603;1499.6550793317538;1642.1214650162165;1822.0616382562982;8186.426950113494;8454.87317690235;8495.95752021239;8806.91193088069;8817.735467935956;8527.95736021319;8665.783355416117;8703.52130632815;8704.869426958585;8717.694880679177;1996.1316827180224;2060.423081537172;2064.84513661476;2274.40865375002;2302.3898666853215;2268.5122698619793;2353.8352315337934;2354.176038386568;2377.465070359164;2377.5720370333333;2232.866028038323;2242.215224671368;2251.549690061994;2253.8422310438277;2272.693186419837;1932.7873933867263;2168.1760930846176;2284.3603790938564;2315.166540045582;2318.6174281243575;2268.988655056714;2304.101400453824;2309.7805708457668;2310.4801419680607;2313.803326717231;8575.313974882058;8646.827063458695;8647.481151130889;8651.221390074923;8652.437591556529;4925.704457732548;5024.62315326352;5036.974815125937;5037.899242015139;5039.143345631252;2945.175350901751;3115.688431156866;3116.298832762633;3130.20179854138;3137.6705445928305;1104.4036220440953;1117.8882111788837;1118.815395459748;1120.4285814234718;1154.8152295632658;11599.76800463986;11609.535618575246;11627.30236185823;11647.242929209575;11654;4278.4865816102265;4309.1381723655395;4365;4395.626371758436;4416.955830441654;9873.703788886345;9880.258980576486;9928.7021389357;9970.900290996997;9976.301658883809;4943.184374578154;4948.777305021283;4952.356193694869;4957.355543779286;4961.454240033593;4100.302948498763;4463.888402789957;4506.3465797459185;4608.193566125915;4661.137689527448;3882.495275614152;3914.5889681583594;3982.303096958021;4022.255882661717;4061.086255592468;1266.695992961701;1299.6101169649066;1308.2608326295613;1313.7438199551186;1314.3362601885985;997.680742162501;997.755549890267;999.9500024998721;1002.3134153105146;1018.1549314069453;5704.201411802351;6006.309274433409;6036.63780173191;6089.695515224221;6190.1952746142715;421.9430376899141;426.6480153873067;436.03200894015237;440.583648452216;443.7781109445277;4026.939595906064;4274.1879042982355;4291.592298731615;4301.505326887385;4359.738415695068;10600.151987840954;10937.070349020263;10951.945240273748;10991.340519568852;11002.119830413547;10126.797464050678;10579.471026448648;10586.417747023834;10847.945760271148;10860.402677852793;7718.961405192938;7821.648025838851;7881.842363152705;7886.802829929297;7891.526508409514;5841.50347220491;6073.271207455134;6115.663638499926;6188.504919606511;6194.296568443714;9861.704148875546;10044.296899216984;10143.28996970205;10153.49232538385;10182.185425166117;9920.801583968425;10057.748556285858;10146.934571869848;10212.642557510451;10314.329568578018;7001.404880585207;7398.889016664647;7430.294122058396;7599.974003509677;7614.352780013761;8288.046874609498;8296.460730052528;8327.292180164512;8373.958130209554;8376.916230837614;7473.51422157558;7645.923540764521;7690.769276921701;7744.612769361622;7761.18507556721;7406.1482929461645;7439.51643143194;7445.478816482794;7485.625718714152;7692.576908269875;6776.390124888783;6784.6946887389195;6831.726730930707;6846.657667116724;6859.108315918898;5198.350206224222;5280.735963201748;5377.8924421510565;5385.488378604183;5393.379761327497;5243;5268.636003172146;5319.574434045189;5398.973005134949;5499.587530935276 08:45:55 INFO - PROCESS | 9696 | |4;prototype.html;299.87105544615804;303.57802654310507;313.78035375237323;314.0860097117389;314.99370012599735;5302.973485132574;5356.544693701036;5390.595705322102;5398.595105367093;5419.268398766166;5102.413222479416;5168.819091331804;5178.6892786432745;5179.19722443021;5344.9198262026;3940.4483372327895;4006.6394024537713;4017.4978127734034;4061.57353477885;4071.7353372030725;4068.8575899843513;4085.407615895693;4088.5707000764937;4091.4476545666253;4111.293813067573;3825.464434979105;4041.1715598302276;4055.655269302113;4070.5346075412826;4073.490813648294;3985.6811455083525;3989.740666856645;4007.5190977082643;4015.859444919414;4034.515858097018;3501.5973163086314;3502.0719509330047;3514.5079688843584;3517.314123745871;3521.0317162780184;4911.901761964777;5083.237514372837;5147.305113809625;5157.149070403379;5167.612429067835;4613.238815595423;4632.652551058684;4646.9070618587775;4650.697704649187;4651.372064771246;5496.0107180707455;5499.587530935196;5509.972450137764;5525.613207075507;5529.30883639545;3853.2486165197797;3870.5355357357016;3874.554426240962;3878.340682084024;3881.87425646565;5497.642653227527;5764.654120752726;5765.481106700375;5801.506871915893;5808.88382232353;3869.2454971280895;3922.1371298314325;3928.723164971396;3929;3940.9605903941165;3978.5424676162033;3988.660963818108;3990.4437269464934;3993.7004724645767;3998.900027499336;4392;4578.771061446914;4621.930671039937;4633.49031606523;4638.6752927294765;5522.591739106502;5557.9995600791435;5570.86072848182;5599.496045355938;5607.355154157324;1318.558282975195;1330.155351351879;1372.499037851177;1391.1444461656008;1392.4987004678308;859.6260626627437;872.5864100157785;872.9742552500786;874.6851133591902;885.455444901381;4779.354787103766;4790.952090479121;4793.760311984387;4794.520547945247;4810.6151507879285;4711.0342379812055;5047.798088076436;5069.315642388304;5073.467285934924;5086.389633243961;4786.521347865186;4787.880302992384;4804.6787133538555;4812.855614331575;4836.758162091881;2693.8922443102447;2703.4863375958503;2707.377303220231;2737.260939546351;2749.628800111959;4972.950270497321;5147.253648220987;5178.197379406198;5180.559652429586;5295.761690723926;5019.799208031711;5091.567216786615;5099.373822481425;5146.30524879144;5170.793168273227;5100.770465329069;5127.077345995252;5165.9151578169;5201.609879259071;5218.816521921701;4853.611711063177;5039.773210205476;5040.823571174991;5044.369453818273;5101.20931255656;4916.582090522345;4948.455669876239;4960.428491486125;4998.625378021074;5037.5214354636255;5147.536721695065;5170.586353091669;5199.140472740053;5204.323437953042;5207.2449494823795;3403.33634941194;3582.7671201371827;3623.5832879218174;3661.4690869823194;3672;4943.629227808001;5002.624803139706;5015.742915688028;5068.467810879952;5142.794288228429;4891.779869905791;4914.582260507754;4915.95084049155;4930.6795058321095;4941.2835138905375;4643.326717625993;4877.6829506081995;4885.853424397274;4945.23348880924;5332.3068001161155;5325.893482130258;5480.876420333742;5493.917591236055;5527.8894422110525;5534.446555344594;5581.888362232814;5607.327120745536;5614.52276556481;5633.746481408264;5648.971755141198;5216.921746173886;5457.426970168075;5472.781088756565;5486.670799752028;5508.91736623943 08:45:55 INFO - PROCESS | 9696 | |5;yui.html;745.5154149802628;767.0948281028387;772.7372693284282;794.7417089445929;803.6062329458567;13817.37821798019;14919.701605967888;14968.850311496895;15360.231988400592;16152.596185095379;15597.532074037797;15629.140397278145;15753.133577653225;15785;15820.367185312602;661.0909998751716;769.830637259802;804.1958041958042;813.276184196066;814.8492528882176;800.3277247112425;811.111832543367;811.2293321344716;811.7199566149669;811.7321283976273;844.1094645149365;850.4174640371366;850.5322072859933;851.7444766570035;856;692.7506097804761;813.9511629302261;838.0948575538404;845.7547311279721;845.9492430454162;617.2222999021266;617.3086143519287;617.789951416516;618.011182108627;618.4959258204594;14292.785608215885;14326.928365358212;14334.42662293507;14347.067440616327;14362.497312594114;13081.41133648988;13092;13377.130486518443;13583.728325433534;13748.175109493463;12360.752784944341;12533.185342952678;12584;12595.101849403614;13165.60503184906;4444.844430444951;4540.772961351952;4545.38637283969;4557.065801510682;4665.323528088408;74556.62721686412;75010.62494687492;75222;76859;77239.22760772433;11169.350239761201;11282.661520154408;11314.773704525864;11435;11503.137264705181;20178.091985860672;21558.78441215599;21564.0296186672;21565.460863478223;21608.13567457284;8563.657453701782;8890.955545222361;9062.139096785795;9062.275017998545;9192.310576706774;4925.729084900293;4944.629152813553;4946.703197808071;5004.424491183488;5184.222366645034;3446.3451944130534;3551.964480355215;3554.8400321985573;3558.679718825318;3564.572251329857;595.7289433307834;611.2206936156347;618.5453691536717;619.5941658213877;623.9968800155971;598.251720591726;623.8378021714296;677.8237658208901;687.1170545848561;717.9461540384492;9379.859302110337;9498.14516693501;9635.759106022406;9661.420314781135;9723.65967191145;642.5181114164377;654.9639769812707;671.0270108342922;684.2370756606348;688.1707542411382;4506.220166695534;4526.6152377047665;4583.633309335245;4635.7450340230935;4669.626429885601;104338;109496.4525177369;111463;113017.86982130237;113810;59512;60820.695896520236;60890;61968;95590;54437.183442248395;69004.30995690079;84953.57523212468;84991.57504212562;85567.99999999875;9000.14498622656;9005.324600654845;9101.681441149529;9110.271178305853;9156.771080723036;50294.49705502898;51915.480845191065;53071.20393194028;53924;55526.444735552126;74146.25853741393;75077.62461187658;75523.62238188993;75938;77492.61253693695;11454.14093942941;11740;11832.467538960595;11882.643520694393;12501.43743531525;12985.415656295301;13014.479420823061;13260.734785304432;13445.932770336085;13588;13571.728565428833;13610.93194534021;13707.588772336845;13719.314034298046;13985.23081230542;12832.422540985865;13119.606411807661;13370.197788132744;13589.388477518338;13616.795748063589;11331.376774277494;11593.884061159617;11952.215032354405;13293;13369.66575835612;10320.896791031993;10555.94722026385;10892.891071089187;11043.39261340634;11233;10833.404162770808;11034.944825275823;11169.776604468028;11765.176437649283;11980.622228443492 08:45:55 INFO - PROCESS | 9696 | __end_tp_report 08:45:55 INFO - PROCESS | 9696 | __start_cc_report 08:45:55 INFO - PROCESS | 9696 | _x_x_mozilla_cycle_collect,842 08:45:55 INFO - PROCESS | 9696 | __end_cc_report 08:45:55 INFO - PROCESS | 9696 | __startTimestamp1465314355873__endTimestamp 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | ------- Summary: start ------- 08:45:55 INFO - PROCESS | 9696 | Number of tests: 6 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#0] dojo.html Cycles:165 Average:5472.57 Median:5647.83 stddev:640.94 (11.3%) stddev-sans-first:615.96 08:45:55 INFO - PROCESS | 9696 | Values: 3128.6 3136.4 3184.0 3185.2 3230.2 5339.7 5404.5 5413.1 5519.0 5533.6 5446.1 5461.0 5544.3 5564.5 5608.2 4875.6 4937.7 4980.7 4997.8 5156.0 5065.0 5082.7 5116.6 5135.6 5141.7 4790.0 4932.2 4937.2 4941.2 4978.7 4920.0 4940.1 5018.9 5026.0 5059.1 4805.4 4940.9 4968.5 4989.8 5023.8 5357.9 5440.0 5478.9 5524.8 5525.4 5947.6 5969.5 5990.5 5999.2 6003.5 5730.6 5823.2 6004.5 6037.8 6048.2 5465.4 5540.7 5582.5 5587.9 5591.8 6044.1 6050.6 6050.7 6064.2 6109.5 5676.8 5752.8 5781.6 5865.5 5871.6 5907.4 5932.3 5938.3 5986.9 5994.6 5869.3 5870.3 5915.7 5918.9 5952.3 5663.2 5747.7 5812.4 5827.6 5937.3 4433.3 4442.1 4443.2 4444.9 4475.2 3929.4 3953.1 3979.7 4006.8 4029.8 5432.2 5486.3 5520.3 5575.0 5582.6 5949.2 5966.8 5971.6 5977.6 6040.3 5597.3 5610.2 5616.6 5620.7 5631.7 4911.2 5029.0 5080.0 5098.7 5126.5 6174.5 6175.8 6176.2 6180.1 6186.0 5671.4 5966.7 5978.9 5979.2 5980.6 6005.7 6065.5 6092.4 6102.0 6124.6 5789.7 5810.5 5811.5 5820.7 5824.5 5647.8 5831.4 5900.1 5924.2 5925.3 5771.6 5809.6 5814.1 5817.6 5868.4 5782.6 5791.1 5791.3 5791.6 5793.9 5468.9 5558.2 5613.7 5680.7 5688.7 5793.4 5802.5 5820.7 5829.0 5844.2 5577.8 5589.5 5595.8 5635.3 5685.9 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#1] ext.html Cycles:180 Average:63431.86 Median:42554.07 stddev:126845.92 (298.1%) stddev-sans-first:127113.99 08:45:55 INFO - PROCESS | 9696 | Values: 583.9 601.0 611.1 621.0 627.9 33777.0 34593.1 34865.7 34880.0 42666.0 44459.8 45082.5 45096.0 45098.5 45113.3 8567.2 8731.3 8731.9 8733.6 8745.4 8786.6 8867.3 8867.8 8958.6 8969.2 8942.9 8969.6 8973.7 8982.6 8983.4 8913.7 8946.4 8978.1 8978.9 8980.7 8725.1 8789.6 8790.4 8932.2 8946.6 42217.8 42737.4 42770.6 42771.1 42838.0 3631.5 3682.1 3749.3 3803.4 3879.9 31112.5 33251.5 33907.2 33913.0 33930.5 4427.6 4476.3 4526.6 4533.0 4662.7 375852.0 380504.1 382886.0 383083.4 384702.0 64629.0 65294.0 65527.3 65626.7 65686.0 36114.6 37048.4 37139.3 39189.6 68801.7 16205.4 16381.9 16382.8 16418.0 16420.3 12080.4 12200.5 12209.6 12210.8 12212.9 20746.2 20807.3 20903.5 20924.7 20997.4 7271.2 7364.5 7461.6 7623.4 7691.4 955.9 1062.3 1140.9 1209.5 1213.2 32753.8 32970.5 33005.7 33361.3 33364.5 1124.5 1132.2 1195.3 1208.9 1214.1 17125.6 17138.0 17344.8 17425.0 17690.6 541932.0 544860.0 547091.0 547115.0 548335.0 58105.7 58622.0 58737.7 58780.7 58806.1 1235.7 1349.3 1369.1 1382.0 1388.7 32218.5 33965.8 34117.1 34138.7 34310.5 49328.8 54502.7 55574.7 56134.2 60901.4 489189.0 489659.0 493322.0 494478.0 495483.0 37208.3 44797.1 46064.3 46899.0 48212.0 48084.0 48228.8 48428.0 48847.5 49203.0 41775.4 41866.0 42095.4 42564.6 43311.8 41323.0 42141.8 42350.2 42428.6 42496.0 41479.0 42033.6 42416.2 42543.6 42663.0 34820.7 37237.4 37373.0 38470.8 38745.4 28446.6 28627.1 28708.3 28870.6 29015.9 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#2] jquery.html Cycles:180 Average:26728.55 Median:37942.53 stddev:68060.40 (179.4%) stddev-sans-first:68222.59 08:45:55 INFO - PROCESS | 9696 | Values: 386.3 391.3 391.4 403.1 418.6 14298.7 17989.5 18401.4 19668.2 19830.6 18139.5 19169.3 19381.9 19671.8 19746.0 5570.6 5746.1 5798.0 5799.9 5802.2 4028.4 4282.9 5568.2 5680.7 5752.1 6029.5 6410.2 6412.6 6417.5 6538.7 6232.2 6280.8 6482.2 6485.7 6490.8 5614.1 5717.4 5737.4 5738.1 5772.3 23025.7 23420.3 24562.3 24606.1 24638.1 2493.0 2539.8 2557.7 2558.2 2663.8 14497.0 14548.7 14616.4 14797.6 15342.3 1927.6 2020.6 2043.5 2050.1 2081.6 79452.0 82519.2 83032.0 83685.6 83853.6 10686.3 10761.3 10995.4 11154.7 11301.5 13336.3 14012.9 14981.0 15527.1 15534.0 7909.0 7927.7 8016.5 8094.6 8122.2 7502.4 7526.1 7555.5 7616.4 7666.2 6838.1 6865.7 6937.3 6950.8 7006.3 1851.2 1915.2 1925.9 1979.5 2013.7 910.3 993.4 1028.8 1051.2 1114.8 19135.9 19399.5 19529.2 19711.3 19779.3 948.4 984.8 989.3 1012.5 1030.4 9693.0 11045.2 11081.9 11118.8 11123.1 404725.0 405055.0 411584.0 412843.0 413215.0 90301.5 91585.5 92268.5 94134.5 95450.0 957.7 958.4 975.1 980.9 1011.5 17273.7 17374.7 17593.9 17634.2 17777.6 28507.4 37488.4 38396.6 40615.2 40670.8 55471.7 56773.4 57540.0 57623.0 58230.4 6324.4 6404.3 6428.9 6429.6 6539.0 11887.8 12805.4 12919.2 12945.7 12998.2 11069.6 11434.5 11523.4 11743.7 12164.3 11475.8 11595.5 11770.5 11853.2 12156.9 11392.4 11594.4 11664.5 11731.4 11963.8 6406.6 6453.3 6482.7 6484.6 6639.4 9627.9 11353.8 11495.3 11819.0 12143.1 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#3] mootools.html Cycles:180 Average:5671.68 Median:2453.83 stddev:3237.32 (131.9%) stddev-sans-first:3230.04 08:45:55 INFO - PROCESS | 9696 | Values: 1340.4 1448.9 1499.7 1642.1 1822.1 8186.4 8454.9 8496.0 8806.9 8817.7 8528.0 8665.8 8703.5 8704.9 8717.7 1996.1 2060.4 2064.8 2274.4 2302.4 2268.5 2353.8 2354.2 2377.5 2377.6 2232.9 2242.2 2251.5 2253.8 2272.7 1932.8 2168.2 2284.4 2315.2 2318.6 2269.0 2304.1 2309.8 2310.5 2313.8 8575.3 8646.8 8647.5 8651.2 8652.4 4925.7 5024.6 5037.0 5037.9 5039.1 2945.2 3115.7 3116.3 3130.2 3137.7 1104.4 1117.9 1118.8 1120.4 1154.8 11599.8 11609.5 11627.3 11647.2 11654.0 4278.5 4309.1 4365.0 4395.6 4417.0 9873.7 9880.3 9928.7 9970.9 9976.3 4943.2 4948.8 4952.4 4957.4 4961.5 4100.3 4463.9 4506.3 4608.2 4661.1 3882.5 3914.6 3982.3 4022.3 4061.1 1266.7 1299.6 1308.3 1313.7 1314.3 997.7 997.8 1000.0 1002.3 1018.2 5704.2 6006.3 6036.6 6089.7 6190.2 421.9 426.6 436.0 440.6 443.8 4026.9 4274.2 4291.6 4301.5 4359.7 10600.2 10937.1 10951.9 10991.3 11002.1 10126.8 10579.5 10586.4 10847.9 10860.4 7719.0 7821.6 7881.8 7886.8 7891.5 5841.5 6073.3 6115.7 6188.5 6194.3 9861.7 10044.3 10143.3 10153.5 10182.2 9920.8 10057.7 10146.9 10212.6 10314.3 7001.4 7398.9 7430.3 7600.0 7614.4 8288.0 8296.5 8327.3 8374.0 8376.9 7473.5 7645.9 7690.8 7744.6 7761.2 7406.1 7439.5 7445.5 7485.6 7692.6 6776.4 6784.7 6831.7 6846.7 6859.1 5198.4 5280.7 5377.9 5385.5 5393.4 5243.0 5268.6 5319.6 5399.0 5499.6 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#4] prototype.html Cycles:180 Average:4404.40 Median:4935.98 stddev:1282.82 (26.0%) stddev-sans-first:1248.88 08:45:55 INFO - PROCESS | 9696 | Values: 299.9 303.6 313.8 314.1 315.0 5303.0 5356.5 5390.6 5398.6 5419.3 5102.4 5168.8 5178.7 5179.2 5344.9 3940.4 4006.6 4017.5 4061.6 4071.7 4068.9 4085.4 4088.6 4091.4 4111.3 3825.5 4041.2 4055.7 4070.5 4073.5 3985.7 3989.7 4007.5 4015.9 4034.5 3501.6 3502.1 3514.5 3517.3 3521.0 4911.9 5083.2 5147.3 5157.1 5167.6 4613.2 4632.7 4646.9 4650.7 4651.4 5496.0 5499.6 5510.0 5525.6 5529.3 3853.2 3870.5 3874.6 3878.3 3881.9 5497.6 5764.7 5765.5 5801.5 5808.9 3869.2 3922.1 3928.7 3929.0 3941.0 3978.5 3988.7 3990.4 3993.7 3998.9 4392.0 4578.8 4621.9 4633.5 4638.7 5522.6 5558.0 5570.9 5599.5 5607.4 1318.6 1330.2 1372.5 1391.1 1392.5 859.6 872.6 873.0 874.7 885.5 4779.4 4791.0 4793.8 4794.5 4810.6 4711.0 5047.8 5069.3 5073.5 5086.4 4786.5 4787.9 4804.7 4812.9 4836.8 2693.9 2703.5 2707.4 2737.3 2749.6 4973.0 5147.3 5178.2 5180.6 5295.8 5019.8 5091.6 5099.4 5146.3 5170.8 5100.8 5127.1 5165.9 5201.6 5218.8 4853.6 5039.8 5040.8 5044.4 5101.2 4916.6 4948.5 4960.4 4998.6 5037.5 5147.5 5170.6 5199.1 5204.3 5207.2 3403.3 3582.8 3623.6 3661.5 3672.0 4943.6 5002.6 5015.7 5068.5 5142.8 4891.8 4914.6 4916.0 4930.7 4941.3 4643.3 4877.7 4885.9 4945.2 5332.3 5325.9 5480.9 5493.9 5527.9 5534.4 5581.9 5607.3 5614.5 5633.7 5649.0 5216.9 5457.4 5472.8 5486.7 5508.9 08:45:55 INFO - PROCESS | 9696 | 08:45:55 INFO - PROCESS | 9696 | [#5] yui.html Cycles:180 Average:19460.63 Median:4935.18 stddev:27230.66 (551.8%) stddev-sans-first:27270.78 08:45:55 INFO - PROCESS | 9696 | Values: 745.5 767.1 772.7 794.7 803.6 13817.4 14919.7 14968.9 15360.2 16152.6 15597.5 15629.1 15753.1 15785.0 15820.4 661.1 769.8 804.2 813.3 814.8 800.3 811.1 811.2 811.7 811.7 844.1 850.4 850.5 851.7 856.0 692.8 814.0 838.1 845.8 845.9 617.2 617.3 617.8 618.0 618.5 14292.8 14326.9 14334.4 14347.1 14362.5 13081.4 13092.0 13377.1 13583.7 13748.2 12360.8 12533.2 12584.0 12595.1 13165.6 4444.8 4540.8 4545.4 4557.1 4665.3 74556.6 75010.6 75222.0 76859.0 77239.2 11169.4 11282.7 11314.8 11435.0 11503.1 20178.1 21558.8 21564.0 21565.5 21608.1 8563.7 8891.0 9062.1 9062.3 9192.3 4925.7 4944.6 4946.7 5004.4 5184.2 3446.3 3552.0 3554.8 3558.7 3564.6 595.7 611.2 618.5 619.6 624.0 598.3 623.8 677.8 687.1 717.9 9379.9 9498.1 9635.8 9661.4 9723.7 642.5 655.0 671.0 684.2 688.2 4506.2 4526.6 4583.6 4635.7 4669.6 104338.0 109496.5 111463.0 113017.9 113810.0 59512.0 60820.7 60890.0 61968.0 95590.0 54437.2 69004.3 84953.6 84991.6 85568.0 9000.1 9005.3 9101.7 9110.3 9156.8 50294.5 51915.5 53071.2 53924.0 55526.4 74146.3 75077.6 75523.6 75938.0 77492.6 11454.1 11740.0 11832.5 11882.6 12501.4 12985.4 13014.5 13260.7 13445.9 13588.0 13571.7 13610.9 13707.6 13719.3 13985.2 12832.4 13119.6 13370.2 13589.4 13616.8 11331.4 11593.9 11952.2 13293.0 13369.7 10320.9 10555.9 10892.9 11043.4 11233.0 10833.4 11034.9 11169.8 11765.2 11980.6 08:45:55 INFO - PROCESS | 9696 | -------- Summary: end -------- 08:45:55 INFO - PROCESS | 9696 | 08:45:56 INFO - TEST-INFO | 9696: exit 0 08:45:56 INFO - TEST-OK | dromaeo_css | took 1113648ms 08:45:56 INFO - TEST-START | kraken 08:45:56 INFO - operating with platform_type : linux_ 08:45:56 INFO - Initialising browser for kraken test... 08:45:56 INFO - TEST-INFO | started process 9876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBv3F9K/profile http://localhost:46198/getInfo.html) 08:46:00 INFO - PROCESS | 9876 | __metrics Screen width/height:1600/1200 08:46:00 INFO - PROCESS | 9876 | colorDepth:24 08:46:00 INFO - PROCESS | 9876 | Browser inner width/height: 1024/697 08:46:00 INFO - PROCESS | 9876 | __metrics 08:46:01 ERROR - PROCESS | 9876 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:46:02 INFO - PROCESS | 9876 | console.error: PushService: 08:46:02 INFO - PROCESS | 9876 | stateChangeProcessEnqueue: Error transitioning state 08:46:02 INFO - PROCESS | 9876 | UnknownError 08:46:02 INFO - TEST-INFO | 9876: exit 0 08:46:02 INFO - Browser initialized. 08:46:02 INFO - Running cycle 1/1 for kraken test... 08:46:02 INFO - TEST-INFO | started process 9962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBv3F9K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:14 INFO - PROCESS | 9962 | RSS: Main: 156930048 08:46:14 INFO - PROCESS | 9962 | 08:46:17 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46198/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:17 INFO - PROCESS | 9962 | RSS: Main: 215490560 08:46:17 INFO - PROCESS | 9962 | 08:46:20 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46198/tests/kraken/driver.html?testName=audio-dft) 08:46:21 INFO - PROCESS | 9962 | RSS: Main: 201347072 08:46:21 INFO - PROCESS | 9962 | 08:46:24 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46198/tests/kraken/driver.html?testName=audio-fft) 08:46:24 INFO - PROCESS | 9962 | RSS: Main: 269168640 08:46:24 INFO - PROCESS | 9962 | 08:46:27 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46198/tests/kraken/driver.html?testName=audio-oscillator) 08:46:27 INFO - PROCESS | 9962 | RSS: Main: 180051968 08:46:27 INFO - PROCESS | 9962 | 08:46:29 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:30 INFO - PROCESS | 9962 | RSS: Main: 184397824 08:46:30 INFO - PROCESS | 9962 | 08:46:33 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46198/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:33 INFO - PROCESS | 9962 | RSS: Main: 219267072 08:46:33 INFO - PROCESS | 9962 | 08:46:37 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46198/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:37 INFO - PROCESS | 9962 | RSS: Main: 220794880 08:46:37 INFO - PROCESS | 9962 | 08:46:40 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46198/tests/kraken/driver.html?testName=json-parse-financial) 08:46:41 INFO - PROCESS | 9962 | RSS: Main: 221368320 08:46:41 INFO - PROCESS | 9962 | 08:46:42 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:43 INFO - PROCESS | 9962 | RSS: Main: 208310272 08:46:43 INFO - PROCESS | 9962 | 08:46:45 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:45 INFO - PROCESS | 9962 | RSS: Main: 212078592 08:46:45 INFO - PROCESS | 9962 | 08:46:47 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:46:48 INFO - PROCESS | 9962 | RSS: Main: 217440256 08:46:48 INFO - PROCESS | 9962 | 08:46:51 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:46:51 INFO - PROCESS | 9962 | RSS: Main: 224608256 08:46:51 INFO - PROCESS | 9962 | 08:46:54 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:55 INFO - PROCESS | 9962 | RSS: Main: 224702464 08:46:55 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | Cycle 1(1): loaded http://localhost:46198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46198/tests/kraken/driver.html?testName=ai-astar) 08:46:56 INFO - PROCESS | 9962 | RSS: Main: 267087872 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | __start_tp_report 08:46:56 INFO - PROCESS | 9962 | _x_x_mozilla_page_load 08:46:56 INFO - PROCESS | 9962 | _x_x_mozilla_page_load_details 08:46:56 INFO - PROCESS | 9962 | |i|pagename|runs| 08:46:56 INFO - PROCESS | 9962 | |0;ai-astar;110;108;112;111;110;111;110;113;111;110 08:46:56 INFO - PROCESS | 9962 | |1;audio-beat-detection;152;129;127;177;138;127;154;131;158;124 08:46:56 INFO - PROCESS | 9962 | |2;audio-dft;162;161;162;161;163;161;160;162;161;163 08:46:56 INFO - PROCESS | 9962 | |3;audio-fft;74;74;75;132;74;76;74;74;99;76 08:46:56 INFO - PROCESS | 9962 | |4;audio-oscillator;85;84;109;84;85;85;112;83;85;122 08:46:56 INFO - PROCESS | 9962 | |5;imaging-gaussian-blur;116;116;116;116;116;117;117;116;117;117 08:46:56 INFO - PROCESS | 9962 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;145;145 08:46:56 INFO - PROCESS | 9962 | |7;imaging-desaturate;95;94;95;94;95;94;96;95;96;95 08:46:56 INFO - PROCESS | 9962 | |8;json-parse-financial;57;54;56;53;55;55;57;56;55;54 08:46:56 INFO - PROCESS | 9962 | |9;json-stringify-tinderbox;63;62;63;62;62;62;62;62;63;63 08:46:56 INFO - PROCESS | 9962 | |10;stanford-crypto-aes;80;79;79;79;79;81;80;80;122;80 08:46:56 INFO - PROCESS | 9962 | |11;stanford-crypto-ccm;121;128;127;129;122;121;144;123;147;123 08:46:56 INFO - PROCESS | 9962 | |12;stanford-crypto-pbkdf2;159;160;164;166;158;163;160;159;158;157 08:46:56 INFO - PROCESS | 9962 | |13;stanford-crypto-sha256-iterative;63;64;66;64;64;63;62;65;61;66 08:46:56 INFO - PROCESS | 9962 | __end_tp_report 08:46:56 INFO - PROCESS | 9962 | __start_cc_report 08:46:56 INFO - PROCESS | 9962 | _x_x_mozilla_cycle_collect,1649 08:46:56 INFO - PROCESS | 9962 | __end_cc_report 08:46:56 INFO - PROCESS | 9962 | __startTimestamp1465314416927__endTimestamp 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | ------- Summary: start ------- 08:46:56 INFO - PROCESS | 9962 | Number of tests: 14 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 08:46:56 INFO - PROCESS | 9962 | Values: 110.0 108.0 112.0 111.0 110.0 111.0 110.0 113.0 111.0 110.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:145.00 stddev:17.65 (12.2%) stddev-sans-first:18.32 08:46:56 INFO - PROCESS | 9962 | Values: 152.0 129.0 127.0 177.0 138.0 127.0 154.0 131.0 158.0 124.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:46:56 INFO - PROCESS | 9962 | Values: 162.0 161.0 162.0 161.0 163.0 161.0 160.0 162.0 161.0 163.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.50 stddev:18.93 (25.4%) stddev-sans-first:19.80 08:46:56 INFO - PROCESS | 9962 | Values: 74.0 74.0 75.0 132.0 74.0 76.0 74.0 74.0 99.0 76.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.50 stddev:14.81 (17.5%) stddev-sans-first:15.39 08:46:56 INFO - PROCESS | 9962 | Values: 85.0 84.0 109.0 84.0 85.0 85.0 112.0 83.0 85.0 122.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:46:56 INFO - PROCESS | 9962 | Values: 116.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:46:56 INFO - PROCESS | 9962 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 08:46:56 INFO - PROCESS | 9962 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 96.0 95.0 96.0 95.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.32 (2.4%) stddev-sans-first:1.22 08:46:56 INFO - PROCESS | 9962 | Values: 57.0 54.0 56.0 53.0 55.0 55.0 57.0 56.0 55.0 54.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:46:56 INFO - PROCESS | 9962 | Values: 63.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.00 stddev:13.40 (16.8%) stddev-sans-first:14.14 08:46:56 INFO - PROCESS | 9962 | Values: 80.0 79.0 79.0 79.0 79.0 81.0 80.0 80.0 122.0 80.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:127.50 stddev:9.43 (7.4%) stddev-sans-first:9.60 08:46:56 INFO - PROCESS | 9962 | Values: 121.0 128.0 127.0 129.0 122.0 121.0 144.0 123.0 147.0 123.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:2.95 (1.8%) stddev-sans-first:3.09 08:46:56 INFO - PROCESS | 9962 | Values: 159.0 160.0 164.0 166.0 158.0 163.0 160.0 159.0 158.0 157.0 08:46:56 INFO - PROCESS | 9962 | 08:46:56 INFO - PROCESS | 9962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.62 (2.5%) stddev-sans-first:1.69 08:46:56 INFO - PROCESS | 9962 | Values: 63.0 64.0 66.0 64.0 64.0 63.0 62.0 65.0 61.0 66.0 08:46:56 INFO - PROCESS | 9962 | -------- Summary: end -------- 08:46:56 INFO - PROCESS | 9962 | 08:46:57 INFO - TEST-INFO | 9962: exit 0 08:46:57 INFO - TEST-OK | kraken | took 61294ms 08:46:57 INFO - SUITE-END | took 1174s 08:46:58 INFO - Completed test suite (00:19:35) 08:46:58 INFO - javascript benchmark 08:46:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.577642018327, 3136.357046805405, 3184.028871194285, 3185.2036990752304, 3230.160158358826, 5339.733013349327, 5404.4595540445935, 5413.052715774734, 5518.9724051379735, 5533.584981126416, 5446.128619420893, 5461.0, 5544.3346798384255, 5564.4713752193575, 5608.158776183574, 4875.585575226101, 4937.654364194508, 4980.676256043345, 4997.775100120485, 5156.04613146569, 5065.0, 5082.695038297714, 5116.616253780962, 5135.6148288878485, 5141.665791723544, 4790.0, 4932.186189278765, 4937.185364414867, 4941.209406494943, 4978.726170060663, 4920.0, 4940.135476291671, 5018.949810501885, 5026.045051440215, 5059.064073146443, 4805.399325084364, 4940.851774446736, 4968.527989840995, 4989.800407983676, 5023.824166154203, 5357.946420535784, 5439.972800136014, 5478.945210547883, 5524.779008839641, 5525.392206857243, 5947.6431414115295, 5969.522438204933, 5990.460858522754, 5999.220101386835, 6003.489703375219, 5730.570207234474, 5823.213866128103, 6004.519638428916, 6037.849053773647, 6048.243969503812, 5465.398806131322, 5540.667559946376, 5582.497575218169, 5587.944120558824, 5591.804286849941, 6044.1469977857205, 6050.570153693604, 6050.728227484377, 6064.15731452978, 6109.5112391008615, 5676.829695109153, 5752.827415177468, 5781.595288329777, 5865.472107510344, 5871.647701137946, 5907.409259074144, 5932.288125424977, 5938.346781853993, 5986.850328741816, 5994.610350327215, 5869.266341707286, 5870.26621672291, 5915.733791979371, 5918.852028699317, 5952.255968003999, 5663.235463212413, 5747.712614369265, 5812.360640329561, 5827.562932780059, 5937.2578427696535, 4433.312836510346, 4442.089371678798, 4443.155800397914, 4444.911101777946, 4475.216837053503, 3929.410588411761, 3953.0710283083454, 3979.7015223858325, 4006.779627120478, 4029.8388064477094, 5432.158015507603, 5486.341639003265, 5520.282363292747, 5575.0, 5582.637128586629, 5949.167116603679, 5966.820995370146, 5971.58198926071, 5977.551683623658, 6040.305364883006, 5597.272354593958, 5610.186522954149, 5616.550675945915, 5620.662760234399, 5631.662100273997, 4911.238757992517, 5028.974855125701, 5080.034793389244, 5098.668586541863, 5126.512981266774, 6174.536909731788, 6175.814725558151, 6176.227971503562, 6180.103884936659, 6185.969070154621, 5671.404502527175, 5966.671833049224, 5978.9402105980125, 5979.162917191509, 5980.581359304807, 6005.699715014319, 6065.514758819196, 6092.390760923872, 6102.0, 6124.6325220486915, 5789.652620842763, 5810.477057064884, 5811.535077193899, 5820.679862607597, 5824.504917081926, 5647.830565083054, 5831.446012628793, 5900.055991041584, 5924.170616113662, 5925.259342582177, 5771.59598828078, 5809.564282678732, 5814.127880817911, 5817.563682723728, 5868.413158684098, 5782.5663075268685, 5791.102379131242, 5791.333996590278, 5791.594588378773, 5793.91309130355, 5468.890622187613, 5558.194061860927, 5613.74738136793, 5680.68756218412, 5688.658680479184, 5793.391693872251, 5802.535797136304, 5820.650760954187, 5829.038208695518, 5844.211031510862, 5577.8047768327915, 5589.469000444951, 5595.832125036255, 5635.323761148688, 5685.857853553694], "value": 5428.171419267508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9211706419635, 601.0083362451953, 611.0986295214557, 620.9782657606984, 627.9466245369143, 33777.0, 34593.13517162075, 34865.651343486556, 34880.0, 42666.0, 44459.77770111145, 45082.54917450825, 45096.0, 45098.549014509845, 45113.32330015044, 8567.186117318844, 8731.301495880314, 8731.869021964676, 8733.606987685569, 8745.387822852403, 8786.560671966408, 8867.290616750644, 8867.822643547126, 8958.552072396387, 8969.192772650493, 8942.86585701215, 8969.641214351419, 8973.730788076367, 8982.550872456351, 8983.371164018521, 8913.732588022338, 8946.418482798663, 8978.057303983052, 8978.910210897873, 8980.730578082603, 8725.083866194022, 8789.64841406343, 8790.428622139605, 8932.151445612657, 8946.55267236642, 42217.78891105525, 42737.35893961593, 42770.57229427697, 42771.14457710859, 42838.0, 3631.509746184258, 3682.097886017916, 3749.2501499699897, 3803.448499967517, 3879.941800872989, 31112.533312000338, 33251.5012274816, 33907.15232119217, 33913.0, 33930.49104263438, 4427.623651989553, 4476.261416866246, 4526.615237704799, 4532.9546704533195, 4662.650301227422, 375852.0, 380504.0974795136, 382886.0, 383083.4379077782, 384701.9999999972, 64629.0, 65294.0, 65527.344726552124, 65626.67186664036, 65686.0, 36114.63885361165, 37048.406611536935, 37139.25721485555, 39189.608103918596, 68801.65599172072, 16205.432809851834, 16381.918090409472, 16382.75425868613, 16418.0, 16420.261088251056, 12080.39598020113, 12200.51197952072, 12209.633710988684, 12210.816837747441, 12212.877871221173, 20746.170153194005, 20807.271745488837, 20903.477413064797, 20924.686129708065, 20997.370078897657, 7271.163816161104, 7364.521306115085, 7461.552306861606, 7623.390128789683, 7691.423143264277, 955.9044095590385, 1062.2988827373897, 1140.937248451343, 1209.4920133543933, 1213.1568559850818, 32753.83623081917, 32970.50544241838, 33005.66994330026, 33361.332773344395, 33364.499532507034, 1124.5389390349917, 1132.1904838040841, 1195.2768575011992, 1208.9335086570322, 1214.1440284599337, 17125.571860703334, 17138.0, 17344.826551734575, 17425.0, 17690.646187076185, 541932.0, 544860.0, 547091.0, 547115.0, 548335.0, 58105.70947145237, 58622.0, 58737.706311469025, 58780.70609646924, 58806.11790823141, 1235.6849003504228, 1349.3455673998103, 1369.0963963783854, 1381.9723605527834, 1388.7014291927082, 32218.516722248718, 33965.83017084899, 34117.147071323416, 34138.65861341355, 34310.48534272038, 49328.75335623299, 54502.7274863639, 55574.72212638911, 56134.157987631035, 60901.39098609134, 489189.0, 489659.0, 493322.0, 494478.0, 495483.0, 37208.255834882606, 44797.104057919314, 46064.309035363825, 46899.0, 48212.0, 48084.0, 48228.794280141876, 48428.0, 48847.5115248843, 49203.0, 41775.37336940009, 41866.0, 42095.36856947087, 42564.57435425606, 43311.783441082596, 41323.0, 42141.78929105458, 42350.15299693927, 42428.57571424246, 42496.0, 41479.0, 42033.57966420297, 42416.151676965674, 42543.5745642552, 42663.0, 34820.65179348174, 37237.44143837791, 37373.0, 38470.80764596159, 38745.4188187183, 28446.57330140008, 28627.14118576446, 28708.282292942844, 28870.566941496316, 29015.85492072526], "value": 20687.7033918679, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3291265277674, 391.3112921258584, 391.42656008946904, 403.12722954802854, 418.6274215947807, 14298.714025719506, 17989.460316190536, 18401.447956561293, 19668.213271469143, 19830.60338793225, 18139.45581632553, 19169.32907348243, 19381.903090484528, 19671.803281967175, 19746.0, 5570.637908535952, 5746.138079288098, 5798.043322851724, 5799.9130013049835, 5802.187693722883, 4028.415879697442, 4282.892927676818, 5568.1647752837, 5680.744366503517, 5752.079667253241, 6029.457348838604, 6410.1987251593555, 6412.615243085406, 6417.486601071926, 6538.705758240891, 6232.189815324002, 6280.783875362422, 6482.157319548475, 6485.740570377179, 6490.8052758417325, 5614.101743721026, 5717.399673034354, 5737.39757325479, 5738.081906894919, 5772.30732312121, 23025.654615180785, 23420.297391078297, 24562.263132105887, 24606.138785142433, 24638.13766518163, 2492.962605560918, 2539.771420572139, 2557.6802899637546, 2558.2069558436942, 2663.8401695898115, 14497.0, 14548.70902581953, 14616.415343386252, 14797.556073317817, 15342.309596068204, 1927.5905118601747, 2020.5655784006362, 2043.4993426610577, 2050.1184490669007, 2081.5628717969244, 79452.0, 82519.17480825174, 83032.0, 83685.58157209175, 83853.58073209594, 10686.305390149615, 10761.30051546647, 10995.395253260987, 11154.665360039211, 11301.491432885376, 13336.266505342106, 14012.859871401359, 14981.0, 15527.068375897483, 15534.0, 7908.960455197687, 7927.722529711433, 8016.478928869605, 8094.595270236465, 8122.213113115105, 7502.362299204519, 7526.09686837583, 7555.546667199986, 7616.352610028099, 7666.195049519832, 6838.076859623887, 6865.656717164122, 6937.3062693731235, 6950.79147625572, 7006.334398232159, 1851.1577232359514, 1915.1669023974616, 1925.9037048147536, 1979.4655443030301, 2013.748281464817, 910.321810251367, 993.3890657245886, 1028.8199565076081, 1051.1800795379615, 1114.7714718482691, 19135.90432047831, 19399.515012124808, 19529.218831246875, 19711.310104146574, 19779.30772422987, 948.3835506920557, 984.7833476635129, 989.2827699917502, 1012.5089331674133, 1030.3560274828233, 9692.95153524242, 11045.226834121695, 11081.889181108247, 11118.777624447466, 11123.110151187886, 404725.0, 405055.0, 411584.0, 412843.0, 413215.0, 90301.54849225843, 91585.54207228922, 92268.53865730629, 94134.52932735429, 95450.0, 957.674390707163, 958.3531116496476, 975.1370037516849, 980.8626792249091, 1011.5043628622069, 17273.749912894607, 17374.739378909075, 17593.912030439766, 17634.206460709043, 17777.644447110728, 28507.42985140327, 37488.43767343547, 38396.6160338393, 40615.18769624532, 40670.79664601658, 55471.722641386536, 56773.41245819634, 57540.0, 57623.0, 58230.4176958225, 6324.367563243639, 6404.327545607644, 6428.935710643021, 6429.646369449725, 6538.967305163634, 11887.76224475523, 12805.359732013549, 12919.22484650924, 12945.676358091123, 12998.155119917175, 11069.612563560559, 11434.485448154686, 11523.366214858263, 11743.70997655449, 12164.2701437914, 11475.770484590428, 11595.536178552764, 11770.529178833094, 11853.170278080452, 12156.93921530422, 11392.373419462008, 11594.420278986187, 11664.475098620413, 11731.41342932833, 11963.76072478563, 6406.647634379968, 6453.322401147811, 6482.70827812759, 6484.610923344614, 6639.435647969976, 9627.855582166414, 11353.772924541629, 11495.310281383145, 11819.0, 12143.149979501704], "value": 9214.04166894169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.3700260877383, 1448.898577099603, 1499.6550793317538, 1642.1214650162165, 1822.0616382562982, 8186.426950113494, 8454.87317690235, 8495.95752021239, 8806.91193088069, 8817.735467935956, 8527.95736021319, 8665.783355416117, 8703.52130632815, 8704.869426958585, 8717.694880679177, 1996.1316827180224, 2060.423081537172, 2064.84513661476, 2274.40865375002, 2302.3898666853215, 2268.5122698619793, 2353.8352315337934, 2354.176038386568, 2377.465070359164, 2377.5720370333333, 2232.866028038323, 2242.215224671368, 2251.549690061994, 2253.8422310438277, 2272.693186419837, 1932.7873933867263, 2168.1760930846176, 2284.3603790938564, 2315.166540045582, 2318.6174281243575, 2268.988655056714, 2304.101400453824, 2309.7805708457668, 2310.4801419680607, 2313.803326717231, 8575.313974882058, 8646.827063458695, 8647.481151130889, 8651.221390074923, 8652.437591556529, 4925.704457732548, 5024.62315326352, 5036.974815125937, 5037.899242015139, 5039.143345631252, 2945.175350901751, 3115.688431156866, 3116.298832762633, 3130.20179854138, 3137.6705445928305, 1104.4036220440953, 1117.8882111788837, 1118.815395459748, 1120.4285814234718, 1154.8152295632658, 11599.76800463986, 11609.535618575246, 11627.30236185823, 11647.242929209575, 11654.0, 4278.4865816102265, 4309.1381723655395, 4365.0, 4395.626371758436, 4416.955830441654, 9873.703788886345, 9880.258980576486, 9928.7021389357, 9970.900290996997, 9976.301658883809, 4943.184374578154, 4948.777305021283, 4952.356193694869, 4957.355543779286, 4961.454240033593, 4100.302948498763, 4463.888402789957, 4506.3465797459185, 4608.193566125915, 4661.137689527448, 3882.495275614152, 3914.5889681583594, 3982.303096958021, 4022.255882661717, 4061.086255592468, 1266.695992961701, 1299.6101169649066, 1308.2608326295613, 1313.7438199551186, 1314.3362601885985, 997.680742162501, 997.755549890267, 999.9500024998721, 1002.3134153105146, 1018.1549314069453, 5704.201411802351, 6006.309274433409, 6036.63780173191, 6089.695515224221, 6190.1952746142715, 421.9430376899141, 426.6480153873067, 436.03200894015237, 440.583648452216, 443.7781109445277, 4026.939595906064, 4274.1879042982355, 4291.592298731615, 4301.505326887385, 4359.738415695068, 10600.151987840954, 10937.070349020263, 10951.945240273748, 10991.340519568852, 11002.119830413547, 10126.797464050678, 10579.471026448648, 10586.417747023834, 10847.945760271148, 10860.402677852793, 7718.961405192938, 7821.648025838851, 7881.842363152705, 7886.802829929297, 7891.526508409514, 5841.50347220491, 6073.271207455134, 6115.663638499926, 6188.504919606511, 6194.296568443714, 9861.704148875546, 10044.296899216984, 10143.28996970205, 10153.49232538385, 10182.185425166117, 9920.801583968425, 10057.748556285858, 10146.934571869848, 10212.642557510451, 10314.329568578018, 7001.404880585207, 7398.889016664647, 7430.294122058396, 7599.974003509677, 7614.352780013761, 8288.046874609498, 8296.460730052528, 8327.292180164512, 8373.958130209554, 8376.916230837614, 7473.51422157558, 7645.923540764521, 7690.769276921701, 7744.612769361622, 7761.18507556721, 7406.1482929461645, 7439.51643143194, 7445.478816482794, 7485.625718714152, 7692.576908269875, 6776.390124888783, 6784.6946887389195, 6831.726730930707, 6846.657667116724, 6859.108315918898, 5198.350206224222, 5280.735963201748, 5377.8924421510565, 5385.488378604183, 5393.379761327497, 5243.0, 5268.636003172146, 5319.574434045189, 5398.973005134949, 5499.587530935276], "value": 4463.867196402335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.87105544615804, 303.57802654310507, 313.78035375237323, 314.0860097117389, 314.99370012599735, 5302.973485132574, 5356.544693701036, 5390.595705322102, 5398.595105367093, 5419.268398766166, 5102.413222479416, 5168.819091331804, 5178.6892786432745, 5179.19722443021, 5344.9198262026, 3940.4483372327895, 4006.6394024537713, 4017.4978127734034, 4061.57353477885, 4071.7353372030725, 4068.8575899843513, 4085.407615895693, 4088.5707000764937, 4091.4476545666253, 4111.293813067573, 3825.464434979105, 4041.1715598302276, 4055.655269302113, 4070.5346075412826, 4073.490813648294, 3985.6811455083525, 3989.740666856645, 4007.5190977082643, 4015.859444919414, 4034.515858097018, 3501.5973163086314, 3502.0719509330047, 3514.5079688843584, 3517.314123745871, 3521.0317162780184, 4911.901761964777, 5083.237514372837, 5147.305113809625, 5157.149070403379, 5167.612429067835, 4613.238815595423, 4632.652551058684, 4646.9070618587775, 4650.697704649187, 4651.372064771246, 5496.0107180707455, 5499.587530935196, 5509.972450137764, 5525.613207075507, 5529.30883639545, 3853.2486165197797, 3870.5355357357016, 3874.554426240962, 3878.340682084024, 3881.87425646565, 5497.642653227527, 5764.654120752726, 5765.481106700375, 5801.506871915893, 5808.88382232353, 3869.2454971280895, 3922.1371298314325, 3928.723164971396, 3929.0, 3940.9605903941165, 3978.5424676162033, 3988.660963818108, 3990.4437269464934, 3993.7004724645767, 3998.900027499336, 4392.0, 4578.771061446914, 4621.930671039937, 4633.49031606523, 4638.6752927294765, 5522.591739106502, 5557.9995600791435, 5570.86072848182, 5599.496045355938, 5607.355154157324, 1318.558282975195, 1330.155351351879, 1372.499037851177, 1391.1444461656008, 1392.4987004678308, 859.6260626627437, 872.5864100157785, 872.9742552500786, 874.6851133591902, 885.455444901381, 4779.354787103766, 4790.952090479121, 4793.760311984387, 4794.520547945247, 4810.6151507879285, 4711.0342379812055, 5047.798088076436, 5069.315642388304, 5073.467285934924, 5086.389633243961, 4786.521347865186, 4787.880302992384, 4804.6787133538555, 4812.855614331575, 4836.758162091881, 2693.8922443102447, 2703.4863375958503, 2707.377303220231, 2737.260939546351, 2749.628800111959, 4972.950270497321, 5147.253648220987, 5178.197379406198, 5180.559652429586, 5295.761690723926, 5019.799208031711, 5091.567216786615, 5099.373822481425, 5146.30524879144, 5170.793168273227, 5100.770465329069, 5127.077345995252, 5165.9151578169, 5201.609879259071, 5218.816521921701, 4853.611711063177, 5039.773210205476, 5040.823571174991, 5044.369453818273, 5101.20931255656, 4916.582090522345, 4948.455669876239, 4960.428491486125, 4998.625378021074, 5037.5214354636255, 5147.536721695065, 5170.586353091669, 5199.140472740053, 5204.323437953042, 5207.2449494823795, 3403.33634941194, 3582.7671201371827, 3623.5832879218174, 3661.4690869823194, 3672.0, 4943.629227808001, 5002.624803139706, 5015.742915688028, 5068.467810879952, 5142.794288228429, 4891.779869905791, 4914.582260507754, 4915.95084049155, 4930.6795058321095, 4941.2835138905375, 4643.326717625993, 4877.6829506081995, 4885.853424397274, 4945.23348880924, 5332.3068001161155, 5325.893482130258, 5480.876420333742, 5493.917591236055, 5527.8894422110525, 5534.446555344594, 5581.888362232814, 5607.327120745536, 5614.52276556481, 5633.746481408264, 5648.971755141198, 5216.921746173886, 5457.426970168075, 5472.781088756565, 5486.670799752028, 5508.91736623943], "value": 3992.776320451454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.5154149802628, 767.0948281028387, 772.7372693284282, 794.7417089445929, 803.6062329458567, 13817.37821798019, 14919.701605967888, 14968.850311496895, 15360.231988400592, 16152.596185095379, 15597.532074037797, 15629.140397278145, 15753.133577653225, 15785.0, 15820.367185312602, 661.0909998751716, 769.830637259802, 804.1958041958042, 813.276184196066, 814.8492528882176, 800.3277247112425, 811.111832543367, 811.2293321344716, 811.7199566149669, 811.7321283976273, 844.1094645149365, 850.4174640371366, 850.5322072859933, 851.7444766570035, 856.0, 692.7506097804761, 813.9511629302261, 838.0948575538404, 845.7547311279721, 845.9492430454162, 617.2222999021266, 617.3086143519287, 617.789951416516, 618.011182108627, 618.4959258204594, 14292.785608215885, 14326.928365358212, 14334.42662293507, 14347.067440616327, 14362.497312594114, 13081.41133648988, 13092.0, 13377.130486518443, 13583.728325433534, 13748.175109493463, 12360.752784944341, 12533.185342952678, 12584.0, 12595.101849403614, 13165.60503184906, 4444.844430444951, 4540.772961351952, 4545.38637283969, 4557.065801510682, 4665.323528088408, 74556.62721686412, 75010.62494687492, 75222.0, 76859.0, 77239.22760772433, 11169.350239761201, 11282.661520154408, 11314.773704525864, 11435.0, 11503.137264705181, 20178.091985860672, 21558.78441215599, 21564.0296186672, 21565.460863478223, 21608.13567457284, 8563.657453701782, 8890.955545222361, 9062.139096785795, 9062.275017998545, 9192.310576706774, 4925.729084900293, 4944.629152813553, 4946.703197808071, 5004.424491183488, 5184.222366645034, 3446.3451944130534, 3551.964480355215, 3554.8400321985573, 3558.679718825318, 3564.572251329857, 595.7289433307834, 611.2206936156347, 618.5453691536717, 619.5941658213877, 623.9968800155971, 598.251720591726, 623.8378021714296, 677.8237658208901, 687.1170545848561, 717.9461540384492, 9379.859302110337, 9498.14516693501, 9635.759106022406, 9661.420314781135, 9723.65967191145, 642.5181114164377, 654.9639769812707, 671.0270108342922, 684.2370756606348, 688.1707542411382, 4506.220166695534, 4526.6152377047665, 4583.633309335245, 4635.7450340230935, 4669.626429885601, 104338.0, 109496.4525177369, 111463.0, 113017.86982130237, 113810.0, 59512.0, 60820.695896520236, 60890.0, 61968.0, 95590.0, 54437.183442248395, 69004.30995690079, 84953.57523212468, 84991.57504212562, 85567.99999999875, 9000.14498622656, 9005.324600654845, 9101.681441149529, 9110.271178305853, 9156.771080723036, 50294.49705502898, 51915.480845191065, 53071.20393194028, 53924.0, 55526.444735552126, 74146.25853741393, 75077.62461187658, 75523.62238188993, 75938.0, 77492.61253693695, 11454.14093942941, 11740.0, 11832.467538960595, 11882.643520694393, 12501.43743531525, 12985.415656295301, 13014.479420823061, 13260.734785304432, 13445.932770336085, 13588.0, 13571.728565428833, 13610.93194534021, 13707.588772336845, 13719.314034298046, 13985.23081230542, 12832.422540985865, 13119.606411807661, 13370.197788132744, 13589.388477518338, 13616.795748063589, 11331.376774277494, 11593.884061159617, 11952.215032354405, 13293.0, 13369.66575835612, 10320.896791031993, 10555.94722026385, 10892.891071089187, 11043.39261340634, 11233.0, 10833.404162770808, 11034.944825275823, 11169.776604468028, 11765.176437649283, 11980.622228443492], "value": 7367.960953764578, "unit": "score"}], "name": "dromaeo_css", "value": 7170.232090071162, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 112.0, 111.0, 110.0, 111.0, 110.0, 113.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 127.0, 177.0, 138.0, 127.0, 154.0, 131.0, 158.0, 124.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 160.0, 162.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 132.0, 74.0, 76.0, 74.0, 74.0, 99.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 84.0, 85.0, 85.0, 112.0, 83.0, 85.0, 122.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 53.0, 55.0, 55.0, 57.0, 56.0, 55.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 81.0, 80.0, 80.0, 122.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 127.0, 129.0, 122.0, 121.0, 144.0, 123.0, 147.0, 123.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 164.0, 166.0, 158.0, 163.0, 160.0, 159.0, 158.0, 157.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 64.0, 63.0, 62.0, 65.0, 61.0, 66.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1501.3000000000002, "alertThreshold": 2.0}]} 08:46:58 INFO - Return code: 0 08:46:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:58 ERROR - # TBPL SUCCESS # 08:46:58 INFO - Running post-action listener: _resource_record_post_action 08:46:58 INFO - ##### 08:46:58 INFO - ##### Finished run-tests step (success) 08:46:58 INFO - ##### 08:46:58 INFO - Running post-run listener: _resource_record_post_run 08:46:58 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 546615296; Read time: 0; Write time: 667020 08:46:58 INFO - TinderboxPrint: CPU usage
13.3% 08:46:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:46:58 INFO - TinderboxPrint: I/O write bytes / time
546,615,296 / 667,020 08:46:58 INFO - TinderboxPrint: CPU idle
8,254.4 (86.7%) 08:46:58 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 08:46:58 INFO - TinderboxPrint: Swap in / out
0 / 0 08:46:58 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254730240; Read time: 0; Write time: 346856 08:46:58 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291299328; Read time: 0; Write time: 320152 08:46:58 INFO - Running post-run listener: _upload_blobber_files 08:46:58 INFO - Blob upload gear active. 08:46:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:46:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:00 INFO - (blobuploader) - INFO - Done attempting. 08:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:00 INFO - (blobuploader) - INFO - Done attempting. 08:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:05 INFO - (blobuploader) - INFO - Done attempting. 08:47:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:05 INFO - Return code: 0 08:47:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2751b6f726cc351cbad44da3b0072debc0c76f1d67a20ab1cf33cf7c9b1ef968c5f7c1739980b5fd1a553c904c3b8dcc97889ebce91047a8f8b4bb03994c33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebaacbdce8bb690b8538bbc3d0348d1a9760812b67640142f10aa76044f66097899d5e39b7fecb44ed7a3fb78af331a41a3a6914288350f8e96b119abb6e1e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c5cbed8e0c294b0a87d69e36d435b4b8748d8d3ac12b379573ff22b1164315d9ad8618542af46df77d974c219aefe4f3d70833beae21e891218715b84503c3b"} 08:47:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:05 INFO - Contents: 08:47:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2751b6f726cc351cbad44da3b0072debc0c76f1d67a20ab1cf33cf7c9b1ef968c5f7c1739980b5fd1a553c904c3b8dcc97889ebce91047a8f8b4bb03994c33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebaacbdce8bb690b8538bbc3d0348d1a9760812b67640142f10aa76044f66097899d5e39b7fecb44ed7a3fb78af331a41a3a6914288350f8e96b119abb6e1e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c5cbed8e0c294b0a87d69e36d435b4b8748d8d3ac12b379573ff22b1164315d9ad8618542af46df77d974c219aefe4f3d70833beae21e891218715b84503c3b"} 08:47:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:05 INFO - Copying logs to upload dir... 08:47:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.447468 ========= master_lag: 0.77 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-07 08:47:05.091575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:47:05.094792) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2751b6f726cc351cbad44da3b0072debc0c76f1d67a20ab1cf33cf7c9b1ef968c5f7c1739980b5fd1a553c904c3b8dcc97889ebce91047a8f8b4bb03994c33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebaacbdce8bb690b8538bbc3d0348d1a9760812b67640142f10aa76044f66097899d5e39b7fecb44ed7a3fb78af331a41a3a6914288350f8e96b119abb6e1e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c5cbed8e0c294b0a87d69e36d435b4b8748d8d3ac12b379573ff22b1164315d9ad8618542af46df77d974c219aefe4f3d70833beae21e891218715b84503c3b"} build_url:https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2751b6f726cc351cbad44da3b0072debc0c76f1d67a20ab1cf33cf7c9b1ef968c5f7c1739980b5fd1a553c904c3b8dcc97889ebce91047a8f8b4bb03994c33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebaacbdce8bb690b8538bbc3d0348d1a9760812b67640142f10aa76044f66097899d5e39b7fecb44ed7a3fb78af331a41a3a6914288350f8e96b119abb6e1e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c5cbed8e0c294b0a87d69e36d435b4b8748d8d3ac12b379573ff22b1164315d9ad8618542af46df77d974c219aefe4f3d70833beae21e891218715b84503c3b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:47:05.120782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:47:05.121118) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465313188.349148-2078924824 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-07 08:47:05.206704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:47:05.207051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:47:05.207421) ========= ========= Total master_lag: 0.92 =========