builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1465238123.59 results: success (0) buildid: 20160606083115 builduid: b8910be4b18a4cf09cdff0b9cc7cee10 revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.590883) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.591364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.591655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.606061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.606337) ========= 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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:35:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-06 11:35:24 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.737789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.738425) ========= 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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014361 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:23.788414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:35:23.788849) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8ee8066ffeea90aabada756a2126349680bccb37 --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 8ee8066ffeea90aabada756a2126349680bccb37 --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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:35:24,145 truncating revision to first 12 chars 2016-06-06 11:35:24,145 Setting DEBUG logging. 2016-06-06 11:35:24,145 attempt 1/10 2016-06-06 11:35:24,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8ee8066ffeea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:35:24,853 unpacking tar archive at: fx-team-8ee8066ffeea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.060621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:35:24.862792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:24.863114) ========= script_repo_revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:24.863523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:24.863790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:35:24.874005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-06 11:35:24.874271) ========= /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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:35:25 INFO - MultiFileLogger online at 20160606 11:35:25 in /builds/slave/test 11:35:25 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 11:35:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:25 INFO - {'append_to_log': False, 11:35:25 INFO - 'base_work_dir': '/builds/slave/test', 11:35:25 INFO - 'blob_upload_branch': 'Fx-Team', 11:35:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:25 INFO - 'branch': 'Fx-Team', 11:35:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:25 INFO - 'config_files': ('talos/linux_config.py',), 11:35:25 INFO - 'default_actions': ('clobber', 11:35:25 INFO - 'read-buildbot-config', 11:35:25 INFO - 'download-and-extract', 11:35:25 INFO - 'populate-webroot', 11:35:25 INFO - 'create-virtualenv', 11:35:25 INFO - 'install', 11:35:25 INFO - 'run-tests'), 11:35:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:25 INFO - 'download_minidump_stackwalk': True, 11:35:25 INFO - 'download_symbols': 'ondemand', 11:35:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:35:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:35:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:35:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:35:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:25 INFO - 'installer_path': 'installer.exe', 11:35:25 INFO - 'log_level': 'info', 11:35:25 INFO - 'log_name': 'talos', 11:35:25 INFO - 'log_to_console': True, 11:35:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:35:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:35:25 INFO - 'opt_config_files': (), 11:35:25 INFO - 'pip_index': False, 11:35:25 INFO - 'sps_profile': False, 11:35:25 INFO - 'sps_profile_interval': 0, 11:35:25 INFO - 'suite': 'dromaeojs', 11:35:25 INFO - 'system_bits': '32', 11:35:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:25 INFO - 'title': 'talos-linux64-ix-050', 11:35:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:25 INFO - 'use_talos_json': True, 11:35:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:25 INFO - 'work_dir': 'build'} 11:35:25 INFO - ##### 11:35:25 INFO - ##### Running clobber step. 11:35:25 INFO - ##### 11:35:25 INFO - Running pre-action listener: _resource_record_pre_action 11:35:25 INFO - Running main action method: clobber 11:35:25 INFO - rmtree: /builds/slave/test/build 11:35:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:25 INFO - Running post-action listener: _resource_record_post_action 11:35:25 INFO - ##### 11:35:25 INFO - ##### Finished clobber step (success) 11:35:25 INFO - ##### 11:35:25 INFO - ##### 11:35:25 INFO - ##### Running read-buildbot-config step. 11:35:25 INFO - ##### 11:35:25 INFO - Running pre-action listener: _resource_record_pre_action 11:35:25 INFO - Running main action method: read_buildbot_config 11:35:25 INFO - Using buildbot properties: 11:35:25 INFO - { 11:35:25 INFO - "project": "", 11:35:25 INFO - "product": "firefox", 11:35:25 INFO - "script_repo_revision": "production", 11:35:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:35:25 INFO - "repository": "", 11:35:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:35:25 INFO - "buildid": "20160606083115", 11:35:25 INFO - "pgo_build": "True", 11:35:25 INFO - "basedir": "/builds/slave/test", 11:35:25 INFO - "buildnumber": 160, 11:35:25 INFO - "slavename": "talos-linux64-ix-050", 11:35:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:35:25 INFO - "platform": "ubuntu64_hw", 11:35:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:35:25 INFO - "branch": "fx-team", 11:35:25 INFO - "repo_path": "integration/fx-team", 11:35:25 INFO - "revision": "8ee8066ffeea90aabada756a2126349680bccb37", 11:35:25 INFO - "stage_platform": "linux64-pgo", 11:35:25 INFO - "builduid": "b8910be4b18a4cf09cdff0b9cc7cee10", 11:35:25 INFO - "slavebuilddir": "test" 11:35:25 INFO - } 11:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:35:25 INFO - Running post-action listener: _resource_record_post_action 11:35:25 INFO - ##### 11:35:25 INFO - ##### Finished read-buildbot-config step (success) 11:35:25 INFO - ##### 11:35:25 INFO - ##### 11:35:25 INFO - ##### Running download-and-extract step. 11:35:25 INFO - ##### 11:35:25 INFO - Running pre-action listener: _resource_record_pre_action 11:35:25 INFO - Running main action method: download_and_extract 11:35:25 INFO - mkdir: /builds/slave/test/build/tests 11:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:25 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:35:26 INFO - Downloaded 1361 bytes. 11:35:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:35:26 INFO - Using the following test package requirements: 11:35:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:35:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:35:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:35:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'jsshell-linux-x86_64.zip'], 11:35:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:35:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:35:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:35:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:35:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:35:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:35:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:26 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:35:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:35:35 INFO - Downloaded 24443794 bytes. 11:35:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:35:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:35:37 INFO - Return code: 0 11:35:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:35: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')]} 11:35:37 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:35:40 INFO - Downloaded 24443794 bytes. 11:35:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:35:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:35:41 INFO - Return code: 0 11:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:41 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:35:42 INFO - Downloaded 10833369 bytes. 11:35:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:35:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:35:43 INFO - Return code: 0 11:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:43 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:36:13 INFO - Downloaded 59181725 bytes. 11:36:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:36:13 INFO - mkdir: /builds/slave/test/properties 11:36:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:36:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:36:13 INFO - Contents: 11:36:13 INFO - build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:36:14 INFO - Running post-action listener: _resource_record_post_action 11:36:14 INFO - Running post-action listener: set_extra_try_arguments 11:36:14 INFO - ##### 11:36:14 INFO - ##### Finished download-and-extract step (success) 11:36:14 INFO - ##### 11:36:14 INFO - ##### 11:36:14 INFO - ##### Running populate-webroot step. 11:36:14 INFO - ##### 11:36:14 INFO - Running pre-action listener: _resource_record_pre_action 11:36:14 INFO - Running main action method: populate_webroot 11:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:36:14 INFO - '--tppagecycles', 11:36:14 INFO - '7'], 11:36:14 INFO - 'tests': ['tsvgm']}}, 11:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:36:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['damp', 'tps']}, 11:36:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'tests': ['damp', 'tps']}, 11:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['dromaeo_dom']}, 11:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['a11yr', 11:36:14 INFO - 'ts_paint', 11:36:14 INFO - 'tpaint', 11:36:14 INFO - 'sessionrestore', 11:36:14 INFO - 'sessionrestore_no_auto_restore', 11:36:14 INFO - 'tabpaint']}, 11:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['tsvgx', 11:36:14 INFO - 'tsvgr_opacity', 11:36:14 INFO - 'tart', 11:36:14 INFO - 'tscrollx', 11:36:14 INFO - 'cart']}, 11:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:36:14 INFO - 'tsvgr_opacity', 11:36:14 INFO - 'tart', 11:36:14 INFO - 'tscrollx', 11:36:14 INFO - 'cart']}, 11:36:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'talos_options': ['--disable-e10s'], 11:36:14 INFO - 'tests': ['tp5o']}, 11:36:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'tests': ['tp5o']}, 11:36:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'talos_options': ['--disable-e10s', 11:36:14 INFO - '--xperf_path', 11:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:14 INFO - 'tests': ['tp5n']}, 11:36:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:14 INFO - 'talos_options': ['--xperf_path', 11:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:14 INFO - 'tests': ['tp5n']}}, 11:36:14 INFO - 'talos.zip': {'path': '', 11:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:36:14 INFO - Running post-action listener: _resource_record_post_action 11:36:14 INFO - ##### 11:36:14 INFO - ##### Finished populate-webroot step (success) 11:36:14 INFO - ##### 11:36:14 INFO - ##### 11:36:14 INFO - ##### Running create-virtualenv step. 11:36:14 INFO - ##### 11:36:14 INFO - Running pre-action listener: _resource_record_pre_action 11:36:14 INFO - Running main action method: create_virtualenv 11:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:36:14 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 11:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:36:14 INFO - Using real prefix '/usr' 11:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:36:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:16 INFO - Installing pip.................done. 11:36:16 INFO - Return code: 0 11:36:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:16 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')]} 11:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:16 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')]} 11:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:16 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:16 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 11:36:16 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 11:36:16 INFO - Using env: {'DISPLAY': ':0', 11:36:16 INFO - 'HOME': '/home/cltbld', 11:36:16 INFO - 'LANG': 'en_US.UTF-8', 11:36:16 INFO - 'LANGUAGE': 'en_US:en', 11:36:16 INFO - 'LOGNAME': 'cltbld', 11:36:16 INFO - 'MAIL': '/var/mail/cltbld', 11:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:16 INFO - 'MOZ_NO_REMOTE': '1', 11:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:16 INFO - 'NO_EM_RESTART': '1', 11:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:16 INFO - 'PWD': '/builds/slave/test', 11:36:16 INFO - 'SHELL': '/bin/bash', 11:36:16 INFO - 'SHLVL': '1', 11:36:16 INFO - 'TERM': 'linux', 11:36:16 INFO - 'TMOUT': '86400', 11:36:16 INFO - 'USER': 'cltbld', 11:36:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:16 INFO - '_': '/tools/buildbot/bin/python'} 11:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:16 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 11:36:16 INFO - Cleaning up... 11:36:16 INFO - Return code: 0 11:36:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:36:16 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')]} 11:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:16 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')]} 11:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:16 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:16 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 11:36:16 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 11:36:16 INFO - Using env: {'DISPLAY': ':0', 11:36:16 INFO - 'HOME': '/home/cltbld', 11:36:16 INFO - 'LANG': 'en_US.UTF-8', 11:36:16 INFO - 'LANGUAGE': 'en_US:en', 11:36:16 INFO - 'LOGNAME': 'cltbld', 11:36:16 INFO - 'MAIL': '/var/mail/cltbld', 11:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:16 INFO - 'MOZ_NO_REMOTE': '1', 11:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:16 INFO - 'NO_EM_RESTART': '1', 11:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:16 INFO - 'PWD': '/builds/slave/test', 11:36:16 INFO - 'SHELL': '/bin/bash', 11:36:16 INFO - 'SHLVL': '1', 11:36:16 INFO - 'TERM': 'linux', 11:36:16 INFO - 'TMOUT': '86400', 11:36:16 INFO - 'USER': 'cltbld', 11:36:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:16 INFO - '_': '/tools/buildbot/bin/python'} 11:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:17 INFO - Downloading/unpacking psutil>=3.1.1 11:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:19 INFO - Installing collected packages: psutil 11:36:19 INFO - Running setup.py install for psutil 11:36:19 INFO - building 'psutil._psutil_linux' extension 11:36:19 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 11:36:19 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 11:36:19 INFO - building 'psutil._psutil_posix' extension 11:36:19 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 11:36:19 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 11:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:19 INFO - Successfully installed psutil 11:36:19 INFO - Cleaning up... 11:36:19 INFO - Return code: 0 11:36:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:19 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 11:36:19 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 11:36:19 INFO - Using env: {'DISPLAY': ':0', 11:36:19 INFO - 'HOME': '/home/cltbld', 11:36:19 INFO - 'LANG': 'en_US.UTF-8', 11:36:19 INFO - 'LANGUAGE': 'en_US:en', 11:36:19 INFO - 'LOGNAME': 'cltbld', 11:36:19 INFO - 'MAIL': '/var/mail/cltbld', 11:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:19 INFO - 'MOZ_NO_REMOTE': '1', 11:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:19 INFO - 'NO_EM_RESTART': '1', 11:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:19 INFO - 'PWD': '/builds/slave/test', 11:36:19 INFO - 'SHELL': '/bin/bash', 11:36:19 INFO - 'SHLVL': '1', 11:36:19 INFO - 'TERM': 'linux', 11:36:19 INFO - 'TMOUT': '86400', 11:36:19 INFO - 'USER': 'cltbld', 11:36:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:19 INFO - '_': '/tools/buildbot/bin/python'} 11:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:36:21 INFO - Installing collected packages: mozsystemmonitor 11:36:21 INFO - Running setup.py install for mozsystemmonitor 11:36:21 INFO - Successfully installed mozsystemmonitor 11:36:21 INFO - Cleaning up... 11:36:22 INFO - Return code: 0 11:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:22 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 11:36:22 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 11:36:22 INFO - Using env: {'DISPLAY': ':0', 11:36:22 INFO - 'HOME': '/home/cltbld', 11:36:22 INFO - 'LANG': 'en_US.UTF-8', 11:36:22 INFO - 'LANGUAGE': 'en_US:en', 11:36:22 INFO - 'LOGNAME': 'cltbld', 11:36:22 INFO - 'MAIL': '/var/mail/cltbld', 11:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:22 INFO - 'MOZ_NO_REMOTE': '1', 11:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:22 INFO - 'NO_EM_RESTART': '1', 11:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:22 INFO - 'PWD': '/builds/slave/test', 11:36:22 INFO - 'SHELL': '/bin/bash', 11:36:22 INFO - 'SHLVL': '1', 11:36:22 INFO - 'TERM': 'linux', 11:36:22 INFO - 'TMOUT': '86400', 11:36:22 INFO - 'USER': 'cltbld', 11:36:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:22 INFO - '_': '/tools/buildbot/bin/python'} 11:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:22 INFO - Downloading/unpacking jsonschema==2.5.1 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:36:24 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 11:36:24 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 11:36:24 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 11:36:24 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 11:36:24 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 11:36:24 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 11:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:24 INFO - warning: no files found matching '*.txt' 11:36:24 INFO - no previously-included directories found matching 'build' 11:36:24 INFO - no previously-included directories found matching 'dist' 11:36:24 INFO - no previously-included directories found matching '.git*' 11:36:24 INFO - Installing collected packages: jsonschema, functools32 11:36:24 INFO - Running setup.py install for functools32 11:36:24 INFO - warning: no files found matching '*.txt' 11:36:24 INFO - no previously-included directories found matching 'build' 11:36:24 INFO - no previously-included directories found matching 'dist' 11:36:24 INFO - no previously-included directories found matching '.git*' 11:36:24 INFO - Successfully installed jsonschema functools32 11:36:24 INFO - Cleaning up... 11:36:24 INFO - Return code: 0 11:36:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36:24 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')]} 11:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:24 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')]} 11:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:24 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:24 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 11:36:24 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 11:36:24 INFO - Using env: {'DISPLAY': ':0', 11:36:24 INFO - 'HOME': '/home/cltbld', 11:36:24 INFO - 'LANG': 'en_US.UTF-8', 11:36:24 INFO - 'LANGUAGE': 'en_US:en', 11:36:24 INFO - 'LOGNAME': 'cltbld', 11:36:24 INFO - 'MAIL': '/var/mail/cltbld', 11:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:24 INFO - 'MOZ_NO_REMOTE': '1', 11:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:24 INFO - 'NO_EM_RESTART': '1', 11:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:24 INFO - 'PWD': '/builds/slave/test', 11:36:24 INFO - 'SHELL': '/bin/bash', 11:36:24 INFO - 'SHLVL': '1', 11:36:24 INFO - 'TERM': 'linux', 11:36:24 INFO - 'TMOUT': '86400', 11:36:24 INFO - 'USER': 'cltbld', 11:36:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:24 INFO - '_': '/tools/buildbot/bin/python'} 11:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:25 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 11:36:25 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 11:36:25 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 11:36:25 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 11:36:25 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 11:36:25 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 11:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 INFO - Downloading docopt-0.6.1.tar.gz 11:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:27 INFO - Running setup.py install for blobuploader 11:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:27 INFO - Running setup.py install for requests 11:36:28 INFO - Running setup.py install for docopt 11:36:28 INFO - Successfully installed blobuploader requests docopt 11:36:28 INFO - Cleaning up... 11:36:28 INFO - Return code: 0 11:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:28 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:28 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 11:36:28 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 11:36:28 INFO - Using env: {'DISPLAY': ':0', 11:36:28 INFO - 'HOME': '/home/cltbld', 11:36:28 INFO - 'LANG': 'en_US.UTF-8', 11:36:28 INFO - 'LANGUAGE': 'en_US:en', 11:36:28 INFO - 'LOGNAME': 'cltbld', 11:36:28 INFO - 'MAIL': '/var/mail/cltbld', 11:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:28 INFO - 'MOZ_NO_REMOTE': '1', 11:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:28 INFO - 'NO_EM_RESTART': '1', 11:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:28 INFO - 'PWD': '/builds/slave/test', 11:36:28 INFO - 'SHELL': '/bin/bash', 11:36:28 INFO - 'SHLVL': '1', 11:36:28 INFO - 'TERM': 'linux', 11:36:28 INFO - 'TMOUT': '86400', 11:36:28 INFO - 'USER': 'cltbld', 11:36:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:28 INFO - '_': '/tools/buildbot/bin/python'} 11:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:28 INFO - Running setup.py (path:/tmp/pip-dANQHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:28 INFO - Running setup.py (path:/tmp/pip-wuRxhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:28 INFO - Running setup.py (path:/tmp/pip-65JJ5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:28 INFO - Running setup.py (path:/tmp/pip-DvNMqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:28 INFO - Running setup.py (path:/tmp/pip-Z3jv7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:28 INFO - Running setup.py (path:/tmp/pip-T7d1Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:28 INFO - Running setup.py (path:/tmp/pip-ILIJHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:29 INFO - Running setup.py (path:/tmp/pip-_FLoCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:29 INFO - Running setup.py (path:/tmp/pip-ZeHAeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:29 INFO - Running setup.py (path:/tmp/pip-mhgkup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:29 INFO - Running setup.py (path:/tmp/pip-fURfhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:29 INFO - Running setup.py (path:/tmp/pip-c28rJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:29 INFO - Running setup.py (path:/tmp/pip-8whyJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:29 INFO - Running setup.py (path:/tmp/pip-kH2Yw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:29 INFO - Running setup.py (path:/tmp/pip-kmKTuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:29 INFO - Running setup.py (path:/tmp/pip-YrCPr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:29 INFO - Running setup.py (path:/tmp/pip-50qJM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:29 INFO - Running setup.py install for manifestparser 11:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:29 INFO - Running setup.py install for mozcrash 11:36:29 INFO - Running setup.py install for mozdebug 11:36:30 INFO - Running setup.py install for mozdevice 11:36:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for mozfile 11:36:30 INFO - Running setup.py install for mozhttpd 11:36:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for mozinfo 11:36:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for mozInstall 11:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for mozleak 11:36:30 INFO - Running setup.py install for mozlog 11:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for moznetwork 11:36:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:30 INFO - Running setup.py install for mozprocess 11:36:31 INFO - Running setup.py install for mozprofile 11:36:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:31 INFO - Running setup.py install for mozrunner 11:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:31 INFO - Running setup.py install for mozscreenshot 11:36:31 INFO - Running setup.py install for moztest 11:36:31 INFO - Running setup.py install for mozversion 11:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:31 INFO - Cleaning up... 11:36:31 INFO - Return code: 0 11:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:31 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:31 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 11:36:31 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 11:36:31 INFO - Using env: {'DISPLAY': ':0', 11:36:31 INFO - 'HOME': '/home/cltbld', 11:36:31 INFO - 'LANG': 'en_US.UTF-8', 11:36:31 INFO - 'LANGUAGE': 'en_US:en', 11:36:31 INFO - 'LOGNAME': 'cltbld', 11:36:31 INFO - 'MAIL': '/var/mail/cltbld', 11:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:31 INFO - 'MOZ_NO_REMOTE': '1', 11:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:31 INFO - 'NO_EM_RESTART': '1', 11:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:31 INFO - 'PWD': '/builds/slave/test', 11:36:31 INFO - 'SHELL': '/bin/bash', 11:36:31 INFO - 'SHLVL': '1', 11:36:31 INFO - 'TERM': 'linux', 11:36:31 INFO - 'TMOUT': '86400', 11:36:31 INFO - 'USER': 'cltbld', 11:36:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:31 INFO - '_': '/tools/buildbot/bin/python'} 11:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:31 INFO - Running setup.py (path:/tmp/pip-OGypIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:31 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)) 11:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:31 INFO - Running setup.py (path:/tmp/pip-s0Xqvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:31 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)) 11:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:31 INFO - Running setup.py (path:/tmp/pip-6Tg8ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:31 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)) 11:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:32 INFO - Running setup.py (path:/tmp/pip-qEyzKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:32 INFO - Running setup.py (path:/tmp/pip-PQk0Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:32 INFO - Running setup.py (path:/tmp/pip-YDqV8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:32 INFO - Running setup.py (path:/tmp/pip-Lb0AHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:32 INFO - Running setup.py (path:/tmp/pip-4XTo73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:32 INFO - Running setup.py (path:/tmp/pip-Y8vDr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:32 INFO - Running setup.py (path:/tmp/pip-6X4b4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:32 INFO - Running setup.py (path:/tmp/pip-ar2eut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:32 INFO - Running setup.py (path:/tmp/pip-G_ae3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:32 INFO - Running setup.py (path:/tmp/pip-gqyzDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:32 INFO - Running setup.py (path:/tmp/pip-_1kIL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:32 INFO - Running setup.py (path:/tmp/pip-8QBPuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:32 INFO - Running setup.py (path:/tmp/pip-owXNwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:32 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)) 11:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:32 INFO - Running setup.py (path:/tmp/pip-TmORJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:34 INFO - Downloading blessings-1.6.tar.gz 11:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:35 INFO - Installing collected packages: blessings 11:36:35 INFO - Running setup.py install for blessings 11:36:35 INFO - Successfully installed blessings 11:36:35 INFO - Cleaning up... 11:36:35 INFO - Return code: 0 11:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:35 INFO - Reading from file tmpfile_stdout 11:36:35 INFO - Current package versions: 11:36:35 INFO - argparse == 1.2.1 11:36:35 INFO - blessings == 1.6 11:36:35 INFO - blobuploader == 1.2.4 11:36:35 INFO - docopt == 0.6.1 11:36:35 INFO - functools32 == 3.2.3-2 11:36:35 INFO - jsonschema == 2.5.1 11:36:35 INFO - manifestparser == 1.1 11:36:35 INFO - mozInstall == 1.12 11:36:35 INFO - mozcrash == 0.17 11:36:35 INFO - mozdebug == 0.1 11:36:35 INFO - mozdevice == 0.48 11:36:35 INFO - mozfile == 1.2 11:36:35 INFO - mozhttpd == 0.7 11:36:35 INFO - mozinfo == 0.9 11:36:35 INFO - mozleak == 0.1 11:36:35 INFO - mozlog == 3.2 11:36:35 INFO - moznetwork == 0.27 11:36:35 INFO - mozprocess == 0.22 11:36:35 INFO - mozprofile == 0.28 11:36:35 INFO - mozrunner == 6.11 11:36:35 INFO - mozscreenshot == 0.1 11:36:35 INFO - mozsystemmonitor == 0.3 11:36:35 INFO - moztest == 0.7 11:36:35 INFO - mozversion == 1.4 11:36:35 INFO - psutil == 3.1.1 11:36:35 INFO - requests == 1.2.3 11:36:35 INFO - wsgiref == 0.1.2 11:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:35 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 11:36:35 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 11:36:35 INFO - Using env: {'DISPLAY': ':0', 11:36:35 INFO - 'HOME': '/home/cltbld', 11:36:35 INFO - 'LANG': 'en_US.UTF-8', 11:36:35 INFO - 'LANGUAGE': 'en_US:en', 11:36:35 INFO - 'LOGNAME': 'cltbld', 11:36:35 INFO - 'MAIL': '/var/mail/cltbld', 11:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:35 INFO - 'MOZ_NO_REMOTE': '1', 11:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:35 INFO - 'NO_EM_RESTART': '1', 11:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:35 INFO - 'PWD': '/builds/slave/test', 11:36:35 INFO - 'SHELL': '/bin/bash', 11:36:35 INFO - 'SHLVL': '1', 11:36:35 INFO - 'TERM': 'linux', 11:36:35 INFO - 'TMOUT': '86400', 11:36:35 INFO - 'USER': 'cltbld', 11:36:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:35 INFO - '_': '/tools/buildbot/bin/python'} 11:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 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)) 11:36:35 INFO - Cleaning up... 11:36:35 INFO - Return code: 0 11:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:35 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 11:36:35 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 11:36:35 INFO - Using env: {'DISPLAY': ':0', 11:36:35 INFO - 'HOME': '/home/cltbld', 11:36:35 INFO - 'LANG': 'en_US.UTF-8', 11:36:35 INFO - 'LANGUAGE': 'en_US:en', 11:36:35 INFO - 'LOGNAME': 'cltbld', 11:36:35 INFO - 'MAIL': '/var/mail/cltbld', 11:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:35 INFO - 'MOZ_NO_REMOTE': '1', 11:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:35 INFO - 'NO_EM_RESTART': '1', 11:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:35 INFO - 'PWD': '/builds/slave/test', 11:36:35 INFO - 'SHELL': '/bin/bash', 11:36:35 INFO - 'SHLVL': '1', 11:36:35 INFO - 'TERM': 'linux', 11:36:35 INFO - 'TMOUT': '86400', 11:36:35 INFO - 'USER': 'cltbld', 11:36:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:35 INFO - '_': '/tools/buildbot/bin/python'} 11:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:35 INFO - Cleaning up... 11:36:35 INFO - Return code: 0 11:36:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 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 0x7f2d2b08df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd59a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, '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': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', '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 11:36:35 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 11:36:35 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 11:36:35 INFO - Using env: {'DISPLAY': ':0', 11:36:35 INFO - 'HOME': '/home/cltbld', 11:36:35 INFO - 'LANG': 'en_US.UTF-8', 11:36:35 INFO - 'LANGUAGE': 'en_US:en', 11:36:35 INFO - 'LOGNAME': 'cltbld', 11:36:35 INFO - 'MAIL': '/var/mail/cltbld', 11:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:35 INFO - 'MOZ_NO_REMOTE': '1', 11:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:35 INFO - 'NO_EM_RESTART': '1', 11:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:35 INFO - 'PWD': '/builds/slave/test', 11:36:35 INFO - 'SHELL': '/bin/bash', 11:36:35 INFO - 'SHLVL': '1', 11:36:35 INFO - 'TERM': 'linux', 11:36:35 INFO - 'TMOUT': '86400', 11:36:35 INFO - 'USER': 'cltbld', 11:36:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:35 INFO - '_': '/tools/buildbot/bin/python'} 11:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:36 INFO - Downloading/unpacking flake8 11:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:36:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:36:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 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 11:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:36:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:38 INFO - no previously-included directories found matching 'docs/_build' 11:36:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:36:38 INFO - Running setup.py install for pep8 11:36:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:38 INFO - no previously-included directories found matching 'docs/_build' 11:36:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:36:38 INFO - Cleaning up... 11:36:38 INFO - Return code: 0 11:36:38 INFO - Running post-action listener: _resource_record_post_action 11:36:38 INFO - Running post-action listener: _start_resource_monitoring 11:36:38 INFO - Starting resource monitoring. 11:36:38 INFO - ##### 11:36:38 INFO - ##### Finished create-virtualenv step (success) 11:36:38 INFO - ##### 11:36:38 INFO - ##### 11:36:38 INFO - ##### Running install step. 11:36:38 INFO - ##### 11:36:38 INFO - Running pre-action listener: _resource_record_pre_action 11:36:38 INFO - Running main action method: install 11:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:39 INFO - Reading from file tmpfile_stdout 11:36:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:39 INFO - Reading from file tmpfile_stdout 11:36:39 INFO - Output received: 11:36:39 INFO - Usage: mozinstall [options] installer 11:36:39 INFO - Options: 11:36:39 INFO - -h, --help show this help message and exit 11:36:39 INFO - -d DEST, --destination=DEST 11:36:39 INFO - Directory to install application into. [default: 11:36:39 INFO - "/builds/slave/test"] 11:36:39 INFO - --app=APP Application being installed. [default: firefox] 11:36:39 INFO - mkdir: /builds/slave/test/build/application 11:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:36:56 INFO - Reading from file tmpfile_stdout 11:36:56 INFO - Output received: 11:36:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:36:56 INFO - Running post-action listener: _resource_record_post_action 11:36:56 INFO - ##### 11:36:56 INFO - ##### Finished install step (success) 11:36:56 INFO - ##### 11:36:56 INFO - ##### 11:36:56 INFO - ##### Running run-tests step. 11:36:56 INFO - ##### 11:36:56 INFO - Running pre-action listener: _resource_record_pre_action 11:36:56 INFO - Running main action method: run_tests 11:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:56 INFO - Python 2.7.3 11:36:56 INFO - Return code: 0 11:36:56 INFO - grabbing minidump binary from tooltool 11:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:56 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 0xd56d00>, '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 0xd57ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd57f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:56 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 11:36:56 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 11:36:56 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 11:36:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:56 INFO - Return code: 0 11:36:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:36:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:36:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:36:57 INFO - Return code: 0 11:36:57 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/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 11:36:57 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/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 11:36:57 INFO - Using env: {'DISPLAY': ':0', 11:36:57 INFO - 'HOME': '/home/cltbld', 11:36:57 INFO - 'LANG': 'en_US.UTF-8', 11:36:57 INFO - 'LANGUAGE': 'en_US:en', 11:36:57 INFO - 'LOGNAME': 'cltbld', 11:36:57 INFO - 'MAIL': '/var/mail/cltbld', 11:36:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:57 INFO - 'MOZ_NO_REMOTE': '1', 11:36:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:57 INFO - 'NO_EM_RESTART': '1', 11:36:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:57 INFO - 'PWD': '/builds/slave/test', 11:36:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:57 INFO - 'SHELL': '/bin/bash', 11:36:57 INFO - 'SHLVL': '1', 11:36:57 INFO - 'TERM': 'linux', 11:36:57 INFO - 'TMOUT': '86400', 11:36:57 INFO - 'USER': 'cltbld', 11:36:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828', 11:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:57 INFO - '_': '/tools/buildbot/bin/python'} 11:36:57 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/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 11:36:57 INFO - mozversion application_buildid: 20160606083115 11:36:57 INFO - mozversion application_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:36:57 INFO - mozversion application_display_name: Nightly 11:36:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:57 INFO - mozversion application_name: Firefox 11:36:57 INFO - mozversion application_remotingname: firefox 11:36:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:36:57 INFO - mozversion application_vendor: Mozilla 11:36:57 INFO - mozversion application_version: 49.0a1 11:36:57 INFO - mozversion platform_buildid: 20160606083115 11:36:57 INFO - mozversion platform_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:36:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:36:57 INFO - mozversion platform_version: 49.0a1 11:36:57 INFO - using testdate: 1465238217 11:36:57 INFO - actual date: 1465238217 11:36:57 INFO - starting webserver on 'localhost:42231' 11:36:57 INFO - SUITE-START | Running 2 tests 11:36:57 INFO - TEST-START | dromaeo_css 11:36:57 INFO - operating with platform_type : linux_ 11:36:57 INFO - Initialising browser for dromaeo_css test... 11:36:57 INFO - TEST-INFO | started process 21374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Q3Ah6/profile http://localhost:42231/getInfo.html) 11:37:01 INFO - PROCESS | 21374 | __metrics Screen width/height:1600/1200 11:37:01 INFO - PROCESS | 21374 | colorDepth:24 11:37:01 INFO - PROCESS | 21374 | Browser inner width/height: 1024/697 11:37:01 INFO - PROCESS | 21374 | __metrics 11:37:01 ERROR - PROCESS | 21374 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:37:02 INFO - PROCESS | 21374 | console.error: PushService: 11:37:02 INFO - PROCESS | 21374 | stateChangeProcessEnqueue: Error transitioning state 11:37:02 INFO - PROCESS | 21374 | UnknownError 11:37:02 INFO - TEST-INFO | 21374: exit 0 11:37:02 INFO - Browser initialized. 11:37:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:02 INFO - TEST-INFO | started process 21454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Q3Ah6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:14 INFO - PROCESS | 21454 | RSS: Main: 156766208 11:37:14 INFO - PROCESS | 21454 | 11:38:05 INFO - PROCESS | 21454 | 1465238285771 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] 11:40:13 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42231/tests/dromaeo/cssquery-ext.html) 11:40:14 INFO - PROCESS | 21454 | RSS: Main: 260804608 11:40:14 INFO - PROCESS | 21454 | 11:43:17 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-ext.html (next: http://localhost:42231/tests/dromaeo/cssquery-jquery.html) 11:43:17 INFO - PROCESS | 21454 | RSS: Main: 245981184 11:43:17 INFO - PROCESS | 21454 | 11:46:19 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42231/tests/dromaeo/cssquery-mootools.html) 11:46:20 INFO - PROCESS | 21454 | RSS: Main: 243785728 11:46:20 INFO - PROCESS | 21454 | 11:49:22 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42231/tests/dromaeo/cssquery-prototype.html) 11:49:22 INFO - PROCESS | 21454 | RSS: Main: 237510656 11:49:22 INFO - PROCESS | 21454 | 11:52:25 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42231/tests/dromaeo/cssquery-yui.html) 11:52:26 INFO - PROCESS | 21454 | RSS: Main: 223100928 11:52:26 INFO - PROCESS | 21454 | 11:55:28 INFO - PROCESS | 21454 | Cycle 1(1): loaded http://localhost:42231/tests/dromaeo/cssquery-yui.html (next: http://localhost:42231/tests/dromaeo/cssquery-dojo.html) 11:55:29 INFO - PROCESS | 21454 | RSS: Main: 278306816 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | __start_tp_report 11:55:29 INFO - PROCESS | 21454 | _x_x_mozilla_page_load 11:55:29 INFO - PROCESS | 21454 | _x_x_mozilla_page_load_details 11:55:29 INFO - PROCESS | 21454 | |i|pagename|runs| 11:55:29 INFO - PROCESS | 21454 | |0;dojo.html;3083.722464978153;3123.344097739475;3125.062481255623;3144.5912031435923;3148.511980643;5263.842084737455;5350.143976963677;5413.242146099545;5480.314960629921;5518.034343989801;5458.890822183564;5479.890402191953;5502.532284755801;5539.141433077869;5541.944580554194;4931.211006239003;4960.528749768766;5026.748662566875;5030.522100400456;5188.584913206934;5064.2403639454005;5092.159793634046;5123.103456895028;5132.615053870974;5149.17613181891;4903.043906438246;4918.631102667278;4920.286558449005;4927.704337739747;4960.578350840165;4917.704937703749;4945.826896058621;5009.448960614366;5011.972545628138;5052.949470505285;4855.708657480563;4959.677620954662;4988.251762235657;5007.674501157413;5035.043341765053;5317.867053323659;5368.248445217633;5388.164834450667;5452.754626041798;5456.290682211326;5874.206982057453;5897.380775018604;5900.76396944126;5908.350081491032;5908.940910590882;5746.540276777848;5807.390224026459;5954.047352423591;5962.373950735154;5976.223090998143;5454.53636440903;5502.5597952163735;5526.4197259288;5550.833474995757;5552.944470555323;6036.08962918894;6059.424354686298;6070.666113363807;6076.21009268801;6079.240094988127;5550.27846379968;5734.139879018181;5740.598158128891;5793.942060579425;5835.824925252249;5859.736311865891;5913.852153696192;5919.230500034968;5950.375210602911;5970.9701451492465;5846.152307915413;5854.151148083504;5871.559633027455;5891.293044834561;5891.762729826784;5650.660960342392;5839.182514447981;5872.706364681749;5878.500327472213;5890.587658863838;4481.731096134243;4484.0583477469445;4487.573680500347;4488.035072459372;4525.705829121097;3941.2708648900043;3962.7424217425773;3980.20395920817;4016.176683779818;4021.9195616087513;5366.114591092426;5456.236126942231;5496.120620700749;5522.558195344443;5544.750486228129;5910.940890591039;5921.230240068763;5922.407759224043;5954.315253745788;5988.071848863433;5568.610197286151;5580.274564306615;5580.581456390787;5583.497485226349;5583.972080139573;4969.204927211629;5063.265826455144;5102.2346648003095;5121.334226550599;5139.948600513947;6156.907646385308;6165.10605962133;6169.105479705418;6169.167162433104;6170.598911070766;5715.485606295453;5990.071538911476;6001.639901605918;6003.459688628044;6006.219191505076;6034.185384972972;6056.36408177135;6075.027995520695;6112.847178820387;6120.908186377119;5818.970905145447;5825.621334613236;5855.824325270249;5860.062390017577;5865.648061116347;5751.654900705971;5839.766409343579;5893.6463812171405;5918.644881307136;5954.642721436728;5724.713764311851;5784.8553786154;5786.652800831964;5787.334456537552;5841.591088623925;5786.652800831964;5791.652500849962;5795.275590551181;5796.21751063601;5796.710164491674;5447.400785913467;5605.859853503695;5650.3219613646625;5687.9431205687415;5697.8860422790485;5855.443732845373;5875.20684707559;5901.350851406428;5902.2622172228475;5910.320313164041;5666.490015898589;5690.630109042899;5708.600397972102;5710.486056254957;5759.280089988752 11:55:29 INFO - PROCESS | 21454 | |1;ext.html;581.4708615160205;606.8058221369162;610.8472881779555;617.4011209127146;620.4725982914521;33551;37120.844728198135;37136.814315928415;37147.628523714826;37150.628493715056;45268.77365613167;45569.77215113928;45638.31542526865;49898.50101498984;49990;8836.204741573241;9006.099390061006;9027.864582031274;9030.187283144516;9039.05089965554;8459.323254139685;8547.487150770943;8548.102449242833;8562.357823163256;8567.31461483083;8621.482711037357;8627.913720862805;8630.352723545728;8631.741047768546;8633.913660863405;8504.78738031548;8565.186307300797;8570.528620925847;8571.742847714548;8581.313494920392;8771.956140219258;8797.076306987738;8855.512946787923;8857.955710221471;8869.113088691143;44088.338674919905;44524.777376112914;44571.77714111441;44599.10801783978;44628;3639.7634153780186;3717.126475278307;3728.776273423576;3830.8467661293516;4178.01816573105;33439.66560334414;33551.832240838885;33917.49123763145;33951.6604833951;35094.47358289628;4361.520232774392;4456.46522417312;4492.573205545468;4590.495045544987;4610.907781844345;364901.9999999973;366021;366545;367290;369128;60541.69729151326;60589.394106059255;60636.696816515636;61011.38988610146;61015;65104.348956510774;65285.673571631836;65393;65401.34598653953;65440;17628;17865.106744662975;17865.821341786675;17869.910650446665;17884.821151788576;13647.727045459034;13696.726065478635;13707.109037912503;13708.3831227593;13731;17070.743938840926;18374.540636484195;18496.44510664682;18499.81500184981;18559.53601159982;5969.61233493382;6419.422251997249;6548.21421429422;6705.731770729214;6779.72881084751;964.8793900762405;1022.8261195596617;1038.7922415516928;1139.6467095200514;1139.7312497828204;33756.662433375845;33928.83035584806;33993.32013359719;34106.14734631654;34156.65843341585;1110.4558766204502;1140.2246472398683;1185.934773587461;1192.0761409907218;1269.4858582274194;17526;17632.911835441;17779.73330400045;17884.9105754473;18006;535965;537447;541033;543281;543517;60305.39694603086;60564.39435605588;60763.39236607666;60850.39149608536;60881.391186088455;1271.9236845789283;1391.9652008699863;1403.0950037225932;1511.168857128575;1632.9755053674205;31504.369912602077;35175.47236791399;35282.294354113284;35393.469097964065;35690.821545892104;52971.73514132559;53789.73105134449;54337.45662543324;54400.72799635977;54500;509276;515734;518779;520563;521552;38520.422193666556;48751.26873096977;48828;49873;49886;49661;49951.500484994685;50021.49978500168;51246.74376628093;51720.48279517156;42384.78807606066;42523;42609.573904260564;43248;44442.555574445134;42401.36397953972;42487.15025699531;43162.78418607887;43189.78405107954;43249.56750432456;41558.79220603878;42591.36112958246;43011.56988430201;43317.566824331356;43317.783411082746;37072.81463592665;37976.62023379731;38246;38612;38952.29953154446;28122;29270.70729292765;29350.706492935653;29435.558466622588;29475 11:55:29 INFO - PROCESS | 21454 | |2;jquery.html;385.9691224702024;386.50720331577236;393.3498971813245;396.2985515637322;414.5709190987329;18255.178516966735;18877.811221887776;18882;19084.427467176007;20560.485987850312;19052.809471905275;19250;19766.802331976676;19786.901065494654;19975.600487990232;5596.160575913605;5614.6631202128;5626.971865140668;5695.14572814077;5768;5535.363433205172;5692.800751973682;5744;5747.741351639186;5791.594588378815;5533.059379905426;5651.32184137904;5705.971470142644;5768.5385169186575;5782.826515204551;5557.972210138943;5617.747201375907;5620.606557540974;5625.212470254168;5651.124075768263;4837.903241935177;5114.539691427789;5117.5650069744115;5201.713905735221;5203.817866374697;13423.530176443875;13728.931355343258;14650.260879995216;22264.44148909577;22313;2071.7513898332145;2211.9557608847895;2269.296518079401;2350.13045173287;2413.5655581995234;9984.90015099847;10327.535260913277;10339.741506462398;13757.243351615658;14194.716105677828;1735.5574328546265;1795.721663142215;1848.9537761555935;1909.3412772593433;1973.5954129403437;85054;86919;86972;89174.10825891723;90021.54989225011;10714.46427678613;10886.836697449544;10938.56245750161;11025.283356581956;11204.495797689124;15243.695126097417;15264.313105910262;15310.081395116329;15346.079235245921;15363.923180384027;8132.715354962548;8401.53791541471;8430.283425908867;8537.060923298432;8570.614322355508;8193.385496087818;8281.21328473794;8283.710070147636;8399.790005249917;8429.241368276884;4692.436907571113;4696.03731235096;4723.645726570521;4815.3258543803195;4883.755812209375;1887.169645356039;1952.1410579345043;1953.45303315072;1967.5081229692578;2030.8883011434514;875.4747151709051;983.6901376066517;1062.7449412141184;1085.630885498934;1105.1379923659558;18912.90543547301;18925.43223703291;19727.704084438745;19779.307724229584;19860.50348741293;971.1890571372842;1012.2610494339026;1034.6585626743156;1058.4866339825178;1068.9144868410508;10526.894731052591;11114.666560003052;11166.05088567481;11196.66410007701;11218.831717524243;477486;488759.6686049712;494821;511225;513016;91819.54090229506;91977.54011229902;92048;92102;93445.5327723357;988.3921388346115;995.6117114325419;1011.1809434358047;1030.8711411073616;1032.0969151992008;17204.91397543004;17350.255224118537;17612.91193544024;17668.293268269124;17750.112494375488;40373.78878633646;40380.192396151324;41016.58983410247;41593;42000.1599968005;56119.438805613056;57449.13826292693;57585.712071439375;58036;58083;8030.63862126194;8265.173482651686;8321.542315172723;8346.374021948257;8488.787780305542;12139.332336721565;13063.608091757262;13129.868701313248;13223.140495867738;13246.271455070064;11376.488058037574;11656.708582285512;11700.824487632523;11753.588624398106;12124.636260912186;6114.7248373822395;10690.62582809598;11307.886921131012;11511.30932144074;11664.591739289084;11448.885511144781;11772.352520611106;11916.344601047025;11919.702007449883;12076.75846483083;7399.8150046249275;7622;7654.272844079804;8253.752387428147;8475.83048339042;8904.73285801427;11760.365722946184;12043.939780301042;12120.878791211975;12154.149209555246 11:55:29 INFO - PROCESS | 21454 | |3;mootools.html;1301.6615679923218;1520.5058356034292;1550.3720992997833;1707.590178357194;1856.387392160587;8413.663453461862;8706.303495720344;8717.171868672474;8770.122987701234;8926.241269492084;8476.957615211932;8771.29829613631;8981.820363592724;8992;8992.460452372863;2313.5719891820027;2353.446939969106;2356.081128359941;2359.516299158677;2361.244401791427;2269.4553307206234;2317.8493397929083;2348.8942997565064;2351.0830775997374;2354;2290.977090229093;2298.2415802785126;2305.101010605865;2342.7891489765916;2350.6944097267415;2244.494988627562;2246.4945387287894;2280.315905228433;2280.350100221437;2290.095412312144;2298.896529665753;2322.6516022596575;2323.848949818256;2325.232673217834;2328.115316179858;8346.791330216793;8394.202550757669;8434.325253979667;8607.35444841633;8916.509591972439;5217.713025783581;5330.147176451749;5343.973280133574;5344.412114667383;5351.866203344908;3406.7785593936314;3460.9826950865086;3517.103138699641;3520.137566296248;3589.0489020409614;1164.9242799218023;1171.9414029298587;1246.7257203415234;1260.3887114749339;2195.110980053081;12677.049221308347;12880.291583962879;12899.871001289961;12905.483780648763;12907.419166137452;4654.418197725285;4672.229082201398;4689.742064186435;4760.119377915097;4770.880727981828;10749;10827;10831.458427078614;10831.67504974852;10831.83752243717;5292.967871265067;5299.12564426873;5301.045811753921;5302.602304827154;5305.045091883421;4227.239096962515;4301.935470967938;4833.95166048335;4861.6353773467135;4863.5622793948005;4143.647789937889;4157.482822272097;4186.5604111568455;4186.769727664947;4211.936820947688;1261.0542093429929;1289.2071376103816;1291.7158225190442;1305.8628843971246;1315.0794443889124;790.6797746912509;969.8254314223508;1007.0533698323552;1020.285799940045;1024.3085917005992;5839.766409343663;5947.791827286111;6006.789762358297;6252.781152659726;6264.248290205113;482.77857021735065;494.0859410091374;501.59120316941573;506.1446155996428;666.3702800853245;4078.1843631273864;4223.408722778813;4239.512456067591;4253.191893540217;4254.425652536868;10991.780164396827;11177.49701263445;11293.548258069584;11317.49071291794;11417.942910285396;11078.944605276922;11180.720481988015;11183.32900026001;11193.832092518618;11264;7840.725574604976;8030.678772849021;8037.276645101969;8452.112528184452;8573.957130214309;5976.402359763989;5989.490893274121;6159.4456498915315;6281.937180628135;6285.59143655661;10100.747481313027;10375.948120259653;10611.840822387516;10613.20400969915;10617.256792024484;9201.355905086848;10628.89371106279;10732.624358147428;10742.086922611354;10769.892301076889;7778.49439786412;7929.207079292025;7955.164707705608;8199.590020498832;8204.261616454547;8116.959415203122;8373.49759014461;8398.664053437795;8663.523506207219;8801.47191168532;7601.809954751176;7672.232776722283;7773.611319433892;7882.763517094496;7915.683372665029;7892.36861051103;7934.365250780039;7946.053216961881;7956.880646790187;8079.313258373104;7214;7326.816829579303;7354.705811767683;7363.521371110861;7372.447066470144;5157.613179011664;5197.194434862602;5204;5229.739606899392;5319.202119682079;5055.51972562606;5219.399769026611;5223.758589426718;5445.646033007842;5492.093804522209 11:55:29 INFO - PROCESS | 21454 | |4;prototype.html;322.2957837125879;324.84569829331053;325.0621955657926;325.2795058944438;337.1873784180125;5357.946420535794;5361.51746342829;5384.738409867855;5393.514583687473;5461.2354270402075;5328.227407025979;5339.22581225722;5360.169173778061;5377.193420986854;5384.111621582444;3976.383660532622;4015.297322968469;4132.5454200037975;4134.813933373005;4158.147579746144;4122.340425531916;4139.648129908961;4150.360607560012;4192.140611174702;4217.641500472449;3965.2267807777353;4137.2552940470705;4143.4199212110325;4149.174363280162;4156.6051225133715;4021.959780402188;4137.069159439132;4137.275976704064;4137.524184718735;4140.67498400512;3647.5805282392334;3649.434337677664;3653.2876089162623;3668.981655091734;3673.412254039341;5094.439611642753;5110.514501122388;5134.614903882224;5134.691918484903;5141.711938187508;4384.868453946387;4665.650076244296;4671.6262698984;4696.802315409549;4706.247000479907;5550.8057217997175;5559.666420014772;5569.749361278752;5579.581531385122;5580.246666699984;3935.0949281665376;3940.763554186758;3952.426898099788;3952.7035472339403;3955.5253369595835;5482.91775623366;5637.46444087811;5659.886802263932;5682.516986056232;5719.170720245583;4001.4998125234347;4031.7580945143386;4033.495813023372;4033.757974521538;4037.414574886625;4076.7769669099152;4078.632923036941;4120.1553681495225;4126.319157339066;4128.731632443882;4596.126735920231;4714;4722.197226471508;4732.503087175865;4742.976285118552;5440.292761941001;5472.5621950243885;5533.972330138324;5558.805441809517;5576.776928922797;1392.2829742682527;1403.933010911694;1411.6329754263966;1411.8517555656508;1413.9505117320844;898.725888603969;915.7115508614766;937.4937533731845;954.174638937328;959.769655282741;5226.372835259717;5302.416734159239;5316.521513063843;5338.359396872323;5342.305500285016;5619.314205738262;5630.774769009194;5663.178839068312;5670.829875103754;5682.374938756816;5097.470758772353;5183.196604526304;5216.869578260498;5217.243499692523;5364.570834333322;2942.3379739558854;3005.8947936822105;3017.2456885778556;3021.425929073469;3027.1826606816035;5626.831195064155;5742.827715168552;5772.604369186824;5823.30120385548;5880.7353669085;5807.477327040587;5815.941840581625;5821.388754180834;5821.565276486893;5822.621529600562;5894.705264736746;5928.851778705567;5929.6145750526075;5974.761009559656;5994.9700251499335;5494.890102198014;5706.400827913009;5722.713864306851;5728.283964504437;5770.451807078321;5598.664080155041;5618.6628802272;5620.718964051699;5645.379008309001;5647.915281270702;5652.26520552342;5932.436418540232;5980.910286345796;5982.970085149721;5997.760089596367;4071.1450595374117;4077.4291599175544;4084.1627466368727;4088.509378874554;4092.3247664135083;5702.51734549012;5709.400512946247;5731.369549349485;5733.39799321082;5767.855803604775;5332.813351532833;5574.275344205227;5600.159976003632;5641.746121424628;5654.604177707685;5519.93002624016;5541.16882467617;5542.140968149944;5542.972285138549;5553.222548843084;5310.522053015247;5336.626436149432;5449.918251226156;5460.972695136657;5519.69641669712;5570.108782594765;5577.163425486209;5594.608377413542;5605.691686957257;5606.495415412633;5439;5463.562914966873;5476.028629693227;5478.986387518322;5501.834944951658 11:55:29 INFO - PROCESS | 21454 | |5;yui.html;745.2696357569579;765;812.8008637883719;835.4945258118838;884.654984556023;15156.1664108474;15819.920900395482;16252.918735406322;16323.347066117356;16364.427245046425;16531.91734041331;16570.83429165708;16646;16701.66596668066;16721.331146754113;682.604089628017;795.308081968688;810.9189081091903;818.2840014986872;824.4599787139433;807.4953154278576;809.3565615335792;812.3338862133053;812.7764864662206;812.8333691593209;846.5132548784474;848.1094850407048;848.8429640516524;850.5067061104576;854.8803167556547;690.520088538466;811.1037303779357;843;855.5166331023014;857.3098655582254;629.6851574212893;632.1118828046602;632.2413104274889;632.2823595219413;632.3360471504901;14524.636884077878;14537.200453975027;14577.635559111;14584.854151458456;14604;13666.248356340397;14077.577672669837;14108.365123569463;14262.572122836227;14455.421783128768;12646.832802722607;12655.683607909783;12786.041046921426;12913.612591622266;12931.030172737082;4432.650695131585;4446.088551846864;4480.955190448087;4525.162844873676;4577.176108300505;77906;79372.20627793706;80803;81136.9999999994;81481.59259203725;11332.71668208285;11335.206535542433;11476.368799715929;11555.191136620524;11720.589779357682;20806.687899681518;20826.583468330547;20860.06129724166;20864.330853531683;21430.249941251983;8058.194180581895;8289.378296627656;8419.452735572168;8459.492430454193;8727.345449091217;4729.07782982322;4774.594159496412;4828.8792780180775;4848.418189817174;4882.633802464829;3630.2013557017412;3772.5472943246436;3775.716821238418;3779.1874746929543;3787.696984241254;640.6348381422638;643.4562794438692;648.6043513456788;658.0622612776774;661.3056290894541;670.6981858163846;708.1961973160397;731.378328420838;792.3621484704753;801.6232370785722;10143.239257055602;10355;10403.53184106717;10452.68641940743;10457.111145552713;646.7994921574327;733.9302766237199;755.4787196834167;756.4100001998451;761.6534476813036;4495.483019452805;5006.2156714162675;5214.165733482625;5347.866303342447;5349.117395629755;122688;123931.38034309771;124064;128450;128758;104962;105821.47089264658;106153;106234;106955.46522267339;94408;95481.99999999862;96251.51874240584;98430.5078474603;100231;10256.333338332985;10417.84373234387;10439.928041509855;10440.321379110334;10545.156387488829;45512;56126.43873561212;57155.42844571501;57697.134542981046;58260.41739582719;73757;74399.25600743924;75559.62220188863;75644.62177689077;76567;14337.354819033377;14398.928005359907;14454.132752034911;14533.200673963034;14823.40706371733;14173.362198700877;14594.197319147548;14812;15657.608559786097;16004.359825606845;13518.72962540724;14536.345864435914;14767.92616036913;14775.92612036933;15015.24923753786;13662.521811736542;13911;14253.358598863284;14417.7837332438;14625.34185961613;13419.932900335436;13646.590602281947;13675.726485470434;13724.862751372359;14003.299835008005;11616.767664646492;11819.468123934272;11875.228110172811;12433.12968092225;12582.87417125817;10722.7340326784;11762.882371176178;11823.704407389883;11915.2255103418;12112.273263604213 11:55:29 INFO - PROCESS | 21454 | __end_tp_report 11:55:29 INFO - PROCESS | 21454 | __start_cc_report 11:55:29 INFO - PROCESS | 21454 | _x_x_mozilla_cycle_collect,873 11:55:29 INFO - PROCESS | 21454 | __end_cc_report 11:55:29 INFO - PROCESS | 21454 | __startTimestamp1465239329033__endTimestamp 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | ------- Summary: start ------- 11:55:29 INFO - PROCESS | 21454 | Number of tests: 6 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#0] dojo.html Cycles:165 Average:5467.44 Median:5690.63 stddev:638.50 (11.2%) stddev-sans-first:612.46 11:55:29 INFO - PROCESS | 21454 | Values: 3083.7 3123.3 3125.1 3144.6 3148.5 5263.8 5350.1 5413.2 5480.3 5518.0 5458.9 5479.9 5502.5 5539.1 5541.9 4931.2 4960.5 5026.7 5030.5 5188.6 5064.2 5092.2 5123.1 5132.6 5149.2 4903.0 4918.6 4920.3 4927.7 4960.6 4917.7 4945.8 5009.4 5012.0 5052.9 4855.7 4959.7 4988.3 5007.7 5035.0 5317.9 5368.2 5388.2 5452.8 5456.3 5874.2 5897.4 5900.8 5908.4 5908.9 5746.5 5807.4 5954.0 5962.4 5976.2 5454.5 5502.6 5526.4 5550.8 5552.9 6036.1 6059.4 6070.7 6076.2 6079.2 5550.3 5734.1 5740.6 5793.9 5835.8 5859.7 5913.9 5919.2 5950.4 5971.0 5846.2 5854.2 5871.6 5891.3 5891.8 5650.7 5839.2 5872.7 5878.5 5890.6 4481.7 4484.1 4487.6 4488.0 4525.7 3941.3 3962.7 3980.2 4016.2 4021.9 5366.1 5456.2 5496.1 5522.6 5544.8 5910.9 5921.2 5922.4 5954.3 5988.1 5568.6 5580.3 5580.6 5583.5 5584.0 4969.2 5063.3 5102.2 5121.3 5139.9 6156.9 6165.1 6169.1 6169.2 6170.6 5715.5 5990.1 6001.6 6003.5 6006.2 6034.2 6056.4 6075.0 6112.8 6120.9 5819.0 5825.6 5855.8 5860.1 5865.6 5751.7 5839.8 5893.6 5918.6 5954.6 5724.7 5784.9 5786.7 5787.3 5841.6 5786.7 5791.7 5795.3 5796.2 5796.7 5447.4 5605.9 5650.3 5687.9 5697.9 5855.4 5875.2 5901.4 5902.3 5910.3 5666.5 5690.6 5708.6 5710.5 5759.3 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#1] ext.html Cycles:180 Average:64431.91 Median:44265.45 stddev:127535.98 (288.1%) stddev-sans-first:127803.65 11:55:29 INFO - PROCESS | 21454 | Values: 581.5 606.8 610.8 617.4 620.5 33551.0 37120.8 37136.8 37147.6 37150.6 45268.8 45569.8 45638.3 49898.5 49990.0 8836.2 9006.1 9027.9 9030.2 9039.1 8459.3 8547.5 8548.1 8562.4 8567.3 8621.5 8627.9 8630.4 8631.7 8633.9 8504.8 8565.2 8570.5 8571.7 8581.3 8772.0 8797.1 8855.5 8858.0 8869.1 44088.3 44524.8 44571.8 44599.1 44628.0 3639.8 3717.1 3728.8 3830.8 4178.0 33439.7 33551.8 33917.5 33951.7 35094.5 4361.5 4456.5 4492.6 4590.5 4610.9 364902.0 366021.0 366545.0 367290.0 369128.0 60541.7 60589.4 60636.7 61011.4 61015.0 65104.3 65285.7 65393.0 65401.3 65440.0 17628.0 17865.1 17865.8 17869.9 17884.8 13647.7 13696.7 13707.1 13708.4 13731.0 17070.7 18374.5 18496.4 18499.8 18559.5 5969.6 6419.4 6548.2 6705.7 6779.7 964.9 1022.8 1038.8 1139.6 1139.7 33756.7 33928.8 33993.3 34106.1 34156.7 1110.5 1140.2 1185.9 1192.1 1269.5 17526.0 17632.9 17779.7 17884.9 18006.0 535965.0 537447.0 541033.0 543281.0 543517.0 60305.4 60564.4 60763.4 60850.4 60881.4 1271.9 1392.0 1403.1 1511.2 1633.0 31504.4 35175.5 35282.3 35393.5 35690.8 52971.7 53789.7 54337.5 54400.7 54500.0 509276.0 515734.0 518779.0 520563.0 521552.0 38520.4 48751.3 48828.0 49873.0 49886.0 49661.0 49951.5 50021.5 51246.7 51720.5 42384.8 42523.0 42609.6 43248.0 44442.6 42401.4 42487.2 43162.8 43189.8 43249.6 41558.8 42591.4 43011.6 43317.6 43317.8 37072.8 37976.6 38246.0 38612.0 38952.3 28122.0 29270.7 29350.7 29435.6 29475.0 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#2] jquery.html Cycles:180 Average:29182.69 Median:2381.85 stddev:82098.53 (3446.8%) stddev-sans-first:82300.36 11:55:29 INFO - PROCESS | 21454 | Values: 386.0 386.5 393.3 396.3 414.6 18255.2 18877.8 18882.0 19084.4 20560.5 19052.8 19250.0 19766.8 19786.9 19975.6 5596.2 5614.7 5627.0 5695.1 5768.0 5535.4 5692.8 5744.0 5747.7 5791.6 5533.1 5651.3 5706.0 5768.5 5782.8 5558.0 5617.7 5620.6 5625.2 5651.1 4837.9 5114.5 5117.6 5201.7 5203.8 13423.5 13728.9 14650.3 22264.4 22313.0 2071.8 2212.0 2269.3 2350.1 2413.6 9984.9 10327.5 10339.7 13757.2 14194.7 1735.6 1795.7 1849.0 1909.3 1973.6 85054.0 86919.0 86972.0 89174.1 90021.5 10714.5 10886.8 10938.6 11025.3 11204.5 15243.7 15264.3 15310.1 15346.1 15363.9 8132.7 8401.5 8430.3 8537.1 8570.6 8193.4 8281.2 8283.7 8399.8 8429.2 4692.4 4696.0 4723.6 4815.3 4883.8 1887.2 1952.1 1953.5 1967.5 2030.9 875.5 983.7 1062.7 1085.6 1105.1 18912.9 18925.4 19727.7 19779.3 19860.5 971.2 1012.3 1034.7 1058.5 1068.9 10526.9 11114.7 11166.1 11196.7 11218.8 477486.0 488759.7 494821.0 511225.0 513016.0 91819.5 91977.5 92048.0 92102.0 93445.5 988.4 995.6 1011.2 1030.9 1032.1 17204.9 17350.3 17612.9 17668.3 17750.1 40373.8 40380.2 41016.6 41593.0 42000.2 56119.4 57449.1 57585.7 58036.0 58083.0 8030.6 8265.2 8321.5 8346.4 8488.8 12139.3 13063.6 13129.9 13223.1 13246.3 11376.5 11656.7 11700.8 11753.6 12124.6 6114.7 10690.6 11307.9 11511.3 11664.6 11448.9 11772.4 11916.3 11919.7 12076.8 7399.8 7622.0 7654.3 8253.8 8475.8 8904.7 11760.4 12043.9 12120.9 12154.1 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#3] mootools.html Cycles:180 Average:5908.00 Median:4680.99 stddev:3402.78 (72.7%) stddev-sans-first:3394.71 11:55:29 INFO - PROCESS | 21454 | Values: 1301.7 1520.5 1550.4 1707.6 1856.4 8413.7 8706.3 8717.2 8770.1 8926.2 8477.0 8771.3 8981.8 8992.0 8992.5 2313.6 2353.4 2356.1 2359.5 2361.2 2269.5 2317.8 2348.9 2351.1 2354.0 2291.0 2298.2 2305.1 2342.8 2350.7 2244.5 2246.5 2280.3 2280.4 2290.1 2298.9 2322.7 2323.8 2325.2 2328.1 8346.8 8394.2 8434.3 8607.4 8916.5 5217.7 5330.1 5344.0 5344.4 5351.9 3406.8 3461.0 3517.1 3520.1 3589.0 1164.9 1171.9 1246.7 1260.4 2195.1 12677.0 12880.3 12899.9 12905.5 12907.4 4654.4 4672.2 4689.7 4760.1 4770.9 10749.0 10827.0 10831.5 10831.7 10831.8 5293.0 5299.1 5301.0 5302.6 5305.0 4227.2 4301.9 4834.0 4861.6 4863.6 4143.6 4157.5 4186.6 4186.8 4211.9 1261.1 1289.2 1291.7 1305.9 1315.1 790.7 969.8 1007.1 1020.3 1024.3 5839.8 5947.8 6006.8 6252.8 6264.2 482.8 494.1 501.6 506.1 666.4 4078.2 4223.4 4239.5 4253.2 4254.4 10991.8 11177.5 11293.5 11317.5 11417.9 11078.9 11180.7 11183.3 11193.8 11264.0 7840.7 8030.7 8037.3 8452.1 8574.0 5976.4 5989.5 6159.4 6281.9 6285.6 10100.7 10375.9 10611.8 10613.2 10617.3 9201.4 10628.9 10732.6 10742.1 10769.9 7778.5 7929.2 7955.2 8199.6 8204.3 8117.0 8373.5 8398.7 8663.5 8801.5 7601.8 7672.2 7773.6 7882.8 7915.7 7892.4 7934.4 7946.1 7956.9 8079.3 7214.0 7326.8 7354.7 7363.5 7372.4 5157.6 5197.2 5204.0 5229.7 5319.2 5055.5 5219.4 5223.8 5445.6 5492.1 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#4] prototype.html Cycles:180 Average:4669.98 Median:5360.84 stddev:1377.03 (25.7%) stddev-sans-first:1341.67 11:55:29 INFO - PROCESS | 21454 | Values: 322.3 324.8 325.1 325.3 337.2 5357.9 5361.5 5384.7 5393.5 5461.2 5328.2 5339.2 5360.2 5377.2 5384.1 3976.4 4015.3 4132.5 4134.8 4158.1 4122.3 4139.6 4150.4 4192.1 4217.6 3965.2 4137.3 4143.4 4149.2 4156.6 4022.0 4137.1 4137.3 4137.5 4140.7 3647.6 3649.4 3653.3 3669.0 3673.4 5094.4 5110.5 5134.6 5134.7 5141.7 4384.9 4665.7 4671.6 4696.8 4706.2 5550.8 5559.7 5569.7 5579.6 5580.2 3935.1 3940.8 3952.4 3952.7 3955.5 5482.9 5637.5 5659.9 5682.5 5719.2 4001.5 4031.8 4033.5 4033.8 4037.4 4076.8 4078.6 4120.2 4126.3 4128.7 4596.1 4714.0 4722.2 4732.5 4743.0 5440.3 5472.6 5534.0 5558.8 5576.8 1392.3 1403.9 1411.6 1411.9 1414.0 898.7 915.7 937.5 954.2 959.8 5226.4 5302.4 5316.5 5338.4 5342.3 5619.3 5630.8 5663.2 5670.8 5682.4 5097.5 5183.2 5216.9 5217.2 5364.6 2942.3 3005.9 3017.2 3021.4 3027.2 5626.8 5742.8 5772.6 5823.3 5880.7 5807.5 5815.9 5821.4 5821.6 5822.6 5894.7 5928.9 5929.6 5974.8 5995.0 5494.9 5706.4 5722.7 5728.3 5770.5 5598.7 5618.7 5620.7 5645.4 5647.9 5652.3 5932.4 5980.9 5983.0 5997.8 4071.1 4077.4 4084.2 4088.5 4092.3 5702.5 5709.4 5731.4 5733.4 5767.9 5332.8 5574.3 5600.2 5641.7 5654.6 5519.9 5541.2 5542.1 5543.0 5553.2 5310.5 5336.6 5449.9 5461.0 5519.7 5570.1 5577.2 5594.6 5605.7 5606.5 5439.0 5463.6 5476.0 5479.0 5501.8 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - PROCESS | 21454 | [#5] yui.html Cycles:180 Average:22088.27 Median:12530.23 stddev:32301.32 (257.8%) stddev-sans-first:32352.17 11:55:29 INFO - PROCESS | 21454 | Values: 745.3 765.0 812.8 835.5 884.7 15156.2 15819.9 16252.9 16323.3 16364.4 16531.9 16570.8 16646.0 16701.7 16721.3 682.6 795.3 810.9 818.3 824.5 807.5 809.4 812.3 812.8 812.8 846.5 848.1 848.8 850.5 854.9 690.5 811.1 843.0 855.5 857.3 629.7 632.1 632.2 632.3 632.3 14524.6 14537.2 14577.6 14584.9 14604.0 13666.2 14077.6 14108.4 14262.6 14455.4 12646.8 12655.7 12786.0 12913.6 12931.0 4432.7 4446.1 4481.0 4525.2 4577.2 77906.0 79372.2 80803.0 81137.0 81481.6 11332.7 11335.2 11476.4 11555.2 11720.6 20806.7 20826.6 20860.1 20864.3 21430.2 8058.2 8289.4 8419.5 8459.5 8727.3 4729.1 4774.6 4828.9 4848.4 4882.6 3630.2 3772.5 3775.7 3779.2 3787.7 640.6 643.5 648.6 658.1 661.3 670.7 708.2 731.4 792.4 801.6 10143.2 10355.0 10403.5 10452.7 10457.1 646.8 733.9 755.5 756.4 761.7 4495.5 5006.2 5214.2 5347.9 5349.1 122688.0 123931.4 124064.0 128450.0 128758.0 104962.0 105821.5 106153.0 106234.0 106955.5 94408.0 95482.0 96251.5 98430.5 100231.0 10256.3 10417.8 10439.9 10440.3 10545.2 45512.0 56126.4 57155.4 57697.1 58260.4 73757.0 74399.3 75559.6 75644.6 76567.0 14337.4 14398.9 14454.1 14533.2 14823.4 14173.4 14594.2 14812.0 15657.6 16004.4 13518.7 14536.3 14767.9 14775.9 15015.2 13662.5 13911.0 14253.4 14417.8 14625.3 13419.9 13646.6 13675.7 13724.9 14003.3 11616.8 11819.5 11875.2 12433.1 12582.9 10722.7 11762.9 11823.7 11915.2 12112.3 11:55:29 INFO - PROCESS | 21454 | -------- Summary: end -------- 11:55:29 INFO - PROCESS | 21454 | 11:55:29 INFO - TEST-INFO | 21454: exit 0 11:55:29 INFO - TEST-OK | dromaeo_css | took 1112576ms 11:55:29 INFO - TEST-START | kraken 11:55:29 INFO - operating with platform_type : linux_ 11:55:29 INFO - Initialising browser for kraken test... 11:55:29 INFO - TEST-INFO | started process 21635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzUZpoj/profile http://localhost:42231/getInfo.html) 11:55:33 INFO - PROCESS | 21635 | __metrics Screen width/height:1600/1200 11:55:33 INFO - PROCESS | 21635 | colorDepth:24 11:55:33 INFO - PROCESS | 21635 | Browser inner width/height: 1024/697 11:55:33 INFO - PROCESS | 21635 | __metrics 11:55:34 ERROR - PROCESS | 21635 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:55:34 INFO - PROCESS | 21635 | console.error: PushService: 11:55:34 INFO - PROCESS | 21635 | stateChangeProcessEnqueue: Error transitioning state 11:55:34 INFO - PROCESS | 21635 | UnknownError 11:55:35 INFO - TEST-INFO | 21635: exit 0 11:55:35 INFO - Browser initialized. 11:55:35 INFO - Running cycle 1/1 for kraken test... 11:55:35 INFO - TEST-INFO | started process 21716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzUZpoj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:47 INFO - PROCESS | 21716 | RSS: Main: 155885568 11:55:47 INFO - PROCESS | 21716 | 11:55:49 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42231/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:50 INFO - PROCESS | 21716 | RSS: Main: 214654976 11:55:50 INFO - PROCESS | 21716 | 11:55:53 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42231/tests/kraken/driver.html?testName=audio-dft) 11:55:54 INFO - PROCESS | 21716 | RSS: Main: 202940416 11:55:54 INFO - PROCESS | 21716 | 11:55:57 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42231/tests/kraken/driver.html?testName=audio-fft) 11:55:57 INFO - PROCESS | 21716 | RSS: Main: 268410880 11:55:57 INFO - PROCESS | 21716 | 11:55:59 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42231/tests/kraken/driver.html?testName=audio-oscillator) 11:56:00 INFO - PROCESS | 21716 | RSS: Main: 179757056 11:56:00 INFO - PROCESS | 21716 | 11:56:02 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:56:03 INFO - PROCESS | 21716 | RSS: Main: 183857152 11:56:03 INFO - PROCESS | 21716 | 11:56:06 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42231/tests/kraken/driver.html?testName=imaging-darkroom) 11:56:06 INFO - PROCESS | 21716 | RSS: Main: 218091520 11:56:06 INFO - PROCESS | 21716 | 11:56:10 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42231/tests/kraken/driver.html?testName=imaging-desaturate) 11:56:10 INFO - PROCESS | 21716 | RSS: Main: 220053504 11:56:10 INFO - PROCESS | 21716 | 11:56:13 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42231/tests/kraken/driver.html?testName=json-parse-financial) 11:56:14 INFO - PROCESS | 21716 | RSS: Main: 221007872 11:56:14 INFO - PROCESS | 21716 | 11:56:15 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:56:16 INFO - PROCESS | 21716 | RSS: Main: 206888960 11:56:16 INFO - PROCESS | 21716 | 11:56:18 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:18 INFO - PROCESS | 21716 | RSS: Main: 211107840 11:56:18 INFO - PROCESS | 21716 | 11:56:20 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:21 INFO - PROCESS | 21716 | RSS: Main: 216440832 11:56:21 INFO - PROCESS | 21716 | 11:56:24 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:24 INFO - PROCESS | 21716 | RSS: Main: 223600640 11:56:24 INFO - PROCESS | 21716 | 11:56:27 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:27 INFO - PROCESS | 21716 | RSS: Main: 224559104 11:56:27 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | Cycle 1(1): loaded http://localhost:42231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42231/tests/kraken/driver.html?testName=ai-astar) 11:56:29 INFO - PROCESS | 21716 | RSS: Main: 266698752 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | __start_tp_report 11:56:29 INFO - PROCESS | 21716 | _x_x_mozilla_page_load 11:56:29 INFO - PROCESS | 21716 | _x_x_mozilla_page_load_details 11:56:29 INFO - PROCESS | 21716 | |i|pagename|runs| 11:56:29 INFO - PROCESS | 21716 | |0;ai-astar;112;105;110;109;111;110;109;111;109;110 11:56:29 INFO - PROCESS | 21716 | |1;audio-beat-detection;161;127;134;181;127;131;149;129;183;128 11:56:29 INFO - PROCESS | 21716 | |2;audio-dft;160;161;161;159;160;161;162;161;162;161 11:56:29 INFO - PROCESS | 21716 | |3;audio-fft;75;75;75;127;75;75;73;74;100;74 11:56:29 INFO - PROCESS | 21716 | |4;audio-oscillator;84;85;116;84;84;86;120;85;86;134 11:56:29 INFO - PROCESS | 21716 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;117;117 11:56:29 INFO - PROCESS | 21716 | |6;imaging-darkroom;147;147;147;147;146;146;146;146;146;146 11:56:29 INFO - PROCESS | 21716 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;96;95 11:56:29 INFO - PROCESS | 21716 | |8;json-parse-financial;54;54;53;53;53;53;54;54;54;54 11:56:29 INFO - PROCESS | 21716 | |9;json-stringify-tinderbox;62;62;62;62;62;62;63;62;62;62 11:56:29 INFO - PROCESS | 21716 | |10;stanford-crypto-aes;80;79;79;80;80;80;81;81;111;79 11:56:29 INFO - PROCESS | 21716 | |11;stanford-crypto-ccm;123;132;124;125;121;118;140;124;139;123 11:56:29 INFO - PROCESS | 21716 | |12;stanford-crypto-pbkdf2;159;163;164;161;159;164;162;159;158;159 11:56:29 INFO - PROCESS | 21716 | |13;stanford-crypto-sha256-iterative;65;64;67;64;62;65;63;63;65;63 11:56:29 INFO - PROCESS | 21716 | __end_tp_report 11:56:29 INFO - PROCESS | 21716 | __start_cc_report 11:56:29 INFO - PROCESS | 21716 | _x_x_mozilla_cycle_collect,1666 11:56:29 INFO - PROCESS | 21716 | __end_cc_report 11:56:29 INFO - PROCESS | 21716 | __startTimestamp1465239389920__endTimestamp 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | ------- Summary: start ------- 11:56:29 INFO - PROCESS | 21716 | Number of tests: 14 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.90 (1.7%) stddev-sans-first:1.80 11:56:29 INFO - PROCESS | 21716 | Values: 112.0 105.0 110.0 109.0 111.0 110.0 109.0 111.0 109.0 110.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:141.50 stddev:22.42 (15.8%) stddev-sans-first:23.02 11:56:29 INFO - PROCESS | 21716 | Values: 161.0 127.0 134.0 181.0 127.0 131.0 149.0 129.0 183.0 128.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 11:56:29 INFO - PROCESS | 21716 | Values: 160.0 161.0 161.0 159.0 160.0 161.0 162.0 161.0 162.0 161.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:17.64 (23.5%) stddev-sans-first:18.52 11:56:29 INFO - PROCESS | 21716 | Values: 75.0 75.0 75.0 127.0 75.0 75.0 73.0 74.0 100.0 74.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.50 stddev:19.13 (22.6%) stddev-sans-first:19.75 11:56:29 INFO - PROCESS | 21716 | Values: 84.0 85.0 116.0 84.0 84.0 86.0 120.0 85.0 86.0 134.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:56:29 INFO - PROCESS | 21716 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:56:29 INFO - PROCESS | 21716 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 11:56:29 INFO - PROCESS | 21716 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 11:56:29 INFO - PROCESS | 21716 | Values: 54.0 54.0 53.0 53.0 53.0 53.0 54.0 54.0 54.0 54.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:56:29 INFO - PROCESS | 21716 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:9.87 (12.3%) stddev-sans-first:10.40 11:56:29 INFO - PROCESS | 21716 | Values: 80.0 79.0 79.0 80.0 80.0 80.0 81.0 81.0 111.0 79.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.50 stddev:7.52 (6.0%) stddev-sans-first:7.84 11:56:29 INFO - PROCESS | 21716 | Values: 123.0 132.0 124.0 125.0 121.0 118.0 140.0 124.0 139.0 123.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.50 stddev:2.30 (1.4%) stddev-sans-first:2.35 11:56:29 INFO - PROCESS | 21716 | Values: 159.0 163.0 164.0 161.0 159.0 164.0 162.0 159.0 158.0 159.0 11:56:29 INFO - PROCESS | 21716 | 11:56:29 INFO - PROCESS | 21716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.45 (2.2%) stddev-sans-first:1.50 11:56:29 INFO - PROCESS | 21716 | Values: 65.0 64.0 67.0 64.0 62.0 65.0 63.0 63.0 65.0 63.0 11:56:29 INFO - PROCESS | 21716 | -------- Summary: end -------- 11:56:29 INFO - PROCESS | 21716 | 11:56:30 INFO - TEST-INFO | 21716: exit 0 11:56:30 INFO - TEST-OK | kraken | took 61100ms 11:56:30 INFO - SUITE-END | took 1173s 11:56:31 INFO - Completed test suite (00:19:33) 11:56:31 INFO - javascript benchmark 11:56:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.722464978153, 3123.344097739475, 3125.062481255623, 3144.5912031435923, 3148.511980643, 5263.842084737455, 5350.143976963677, 5413.242146099545, 5480.314960629921, 5518.034343989801, 5458.890822183564, 5479.890402191953, 5502.532284755801, 5539.141433077869, 5541.944580554194, 4931.211006239003, 4960.528749768766, 5026.748662566875, 5030.522100400456, 5188.584913206934, 5064.2403639454005, 5092.159793634046, 5123.103456895028, 5132.615053870974, 5149.17613181891, 4903.043906438246, 4918.631102667278, 4920.286558449005, 4927.704337739747, 4960.578350840165, 4917.704937703749, 4945.826896058621, 5009.448960614366, 5011.972545628138, 5052.949470505285, 4855.708657480563, 4959.677620954662, 4988.251762235657, 5007.674501157413, 5035.043341765053, 5317.867053323659, 5368.248445217633, 5388.164834450667, 5452.754626041798, 5456.290682211326, 5874.206982057453, 5897.380775018604, 5900.76396944126, 5908.350081491032, 5908.940910590882, 5746.540276777848, 5807.390224026459, 5954.047352423591, 5962.373950735154, 5976.223090998143, 5454.53636440903, 5502.5597952163735, 5526.4197259288, 5550.833474995757, 5552.944470555323, 6036.08962918894, 6059.424354686298, 6070.666113363807, 6076.21009268801, 6079.240094988127, 5550.27846379968, 5734.139879018181, 5740.598158128891, 5793.942060579425, 5835.824925252249, 5859.736311865891, 5913.852153696192, 5919.230500034968, 5950.375210602911, 5970.9701451492465, 5846.152307915413, 5854.151148083504, 5871.559633027455, 5891.293044834561, 5891.762729826784, 5650.660960342392, 5839.182514447981, 5872.706364681749, 5878.500327472213, 5890.587658863838, 4481.731096134243, 4484.0583477469445, 4487.573680500347, 4488.035072459372, 4525.705829121097, 3941.2708648900043, 3962.7424217425773, 3980.20395920817, 4016.176683779818, 4021.9195616087513, 5366.114591092426, 5456.236126942231, 5496.120620700749, 5522.558195344443, 5544.750486228129, 5910.940890591039, 5921.230240068763, 5922.407759224043, 5954.315253745788, 5988.071848863433, 5568.610197286151, 5580.274564306615, 5580.581456390787, 5583.497485226349, 5583.972080139573, 4969.204927211629, 5063.265826455144, 5102.2346648003095, 5121.334226550599, 5139.948600513947, 6156.907646385308, 6165.10605962133, 6169.105479705418, 6169.167162433104, 6170.598911070766, 5715.485606295453, 5990.071538911476, 6001.639901605918, 6003.459688628044, 6006.219191505076, 6034.185384972972, 6056.36408177135, 6075.027995520695, 6112.847178820387, 6120.908186377119, 5818.970905145447, 5825.621334613236, 5855.824325270249, 5860.062390017577, 5865.648061116347, 5751.654900705971, 5839.766409343579, 5893.6463812171405, 5918.644881307136, 5954.642721436728, 5724.713764311851, 5784.8553786154, 5786.652800831964, 5787.334456537552, 5841.591088623925, 5786.652800831964, 5791.652500849962, 5795.275590551181, 5796.21751063601, 5796.710164491674, 5447.400785913467, 5605.859853503695, 5650.3219613646625, 5687.9431205687415, 5697.8860422790485, 5855.443732845373, 5875.20684707559, 5901.350851406428, 5902.2622172228475, 5910.320313164041, 5666.490015898589, 5690.630109042899, 5708.600397972102, 5710.486056254957, 5759.280089988752], "value": 5422.926721161282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4708615160205, 606.8058221369162, 610.8472881779555, 617.4011209127146, 620.4725982914521, 33551.0, 37120.844728198135, 37136.814315928415, 37147.628523714826, 37150.628493715056, 45268.77365613167, 45569.77215113928, 45638.31542526865, 49898.50101498984, 49990.0, 8836.204741573241, 9006.099390061006, 9027.864582031274, 9030.187283144516, 9039.05089965554, 8459.323254139685, 8547.487150770943, 8548.102449242833, 8562.357823163256, 8567.31461483083, 8621.482711037357, 8627.913720862805, 8630.352723545728, 8631.741047768546, 8633.913660863405, 8504.78738031548, 8565.186307300797, 8570.528620925847, 8571.742847714548, 8581.313494920392, 8771.956140219258, 8797.076306987738, 8855.512946787923, 8857.955710221471, 8869.113088691143, 44088.338674919905, 44524.777376112914, 44571.77714111441, 44599.10801783978, 44628.0, 3639.7634153780186, 3717.126475278307, 3728.776273423576, 3830.8467661293516, 4178.01816573105, 33439.66560334414, 33551.832240838885, 33917.49123763145, 33951.6604833951, 35094.47358289628, 4361.520232774392, 4456.46522417312, 4492.573205545468, 4590.495045544987, 4610.907781844345, 364901.9999999973, 366021.0, 366545.0, 367290.0, 369128.0, 60541.69729151326, 60589.394106059255, 60636.696816515636, 61011.38988610146, 61015.0, 65104.348956510774, 65285.673571631836, 65393.0, 65401.34598653953, 65440.0, 17628.0, 17865.106744662975, 17865.821341786675, 17869.910650446665, 17884.821151788576, 13647.727045459034, 13696.726065478635, 13707.109037912503, 13708.3831227593, 13731.0, 17070.743938840926, 18374.540636484195, 18496.44510664682, 18499.81500184981, 18559.53601159982, 5969.61233493382, 6419.422251997249, 6548.21421429422, 6705.731770729214, 6779.72881084751, 964.8793900762405, 1022.8261195596617, 1038.7922415516928, 1139.6467095200514, 1139.7312497828204, 33756.662433375845, 33928.83035584806, 33993.32013359719, 34106.14734631654, 34156.65843341585, 1110.4558766204502, 1140.2246472398683, 1185.934773587461, 1192.0761409907218, 1269.4858582274194, 17526.0, 17632.911835441, 17779.73330400045, 17884.9105754473, 18006.0, 535965.0, 537447.0, 541033.0, 543281.0, 543517.0, 60305.39694603086, 60564.39435605588, 60763.39236607666, 60850.39149608536, 60881.391186088455, 1271.9236845789283, 1391.9652008699863, 1403.0950037225932, 1511.168857128575, 1632.9755053674205, 31504.369912602077, 35175.47236791399, 35282.294354113284, 35393.469097964065, 35690.821545892104, 52971.73514132559, 53789.73105134449, 54337.45662543324, 54400.72799635977, 54500.0, 509276.0, 515734.0, 518779.0, 520563.0, 521552.0, 38520.422193666556, 48751.26873096977, 48828.0, 49873.0, 49886.0, 49661.0, 49951.500484994685, 50021.49978500168, 51246.74376628093, 51720.48279517156, 42384.78807606066, 42523.0, 42609.573904260564, 43248.0, 44442.555574445134, 42401.36397953972, 42487.15025699531, 43162.78418607887, 43189.78405107954, 43249.56750432456, 41558.79220603878, 42591.36112958246, 43011.56988430201, 43317.566824331356, 43317.783411082746, 37072.81463592665, 37976.62023379731, 38246.0, 38612.0, 38952.29953154446, 28122.0, 29270.70729292765, 29350.706492935653, 29435.558466622588, 29475.0], "value": 21023.164309522766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9691224702024, 386.50720331577236, 393.3498971813245, 396.2985515637322, 414.5709190987329, 18255.178516966735, 18877.811221887776, 18882.0, 19084.427467176007, 20560.485987850312, 19052.809471905275, 19250.0, 19766.802331976676, 19786.901065494654, 19975.600487990232, 5596.160575913605, 5614.6631202128, 5626.971865140668, 5695.14572814077, 5768.0, 5535.363433205172, 5692.800751973682, 5744.0, 5747.741351639186, 5791.594588378815, 5533.059379905426, 5651.32184137904, 5705.971470142644, 5768.5385169186575, 5782.826515204551, 5557.972210138943, 5617.747201375907, 5620.606557540974, 5625.212470254168, 5651.124075768263, 4837.903241935177, 5114.539691427789, 5117.5650069744115, 5201.713905735221, 5203.817866374697, 13423.530176443875, 13728.931355343258, 14650.260879995216, 22264.44148909577, 22313.0, 2071.7513898332145, 2211.9557608847895, 2269.296518079401, 2350.13045173287, 2413.5655581995234, 9984.90015099847, 10327.535260913277, 10339.741506462398, 13757.243351615658, 14194.716105677828, 1735.5574328546265, 1795.721663142215, 1848.9537761555935, 1909.3412772593433, 1973.5954129403437, 85054.0, 86919.0, 86972.0, 89174.10825891723, 90021.54989225011, 10714.46427678613, 10886.836697449544, 10938.56245750161, 11025.283356581956, 11204.495797689124, 15243.695126097417, 15264.313105910262, 15310.081395116329, 15346.079235245921, 15363.923180384027, 8132.715354962548, 8401.53791541471, 8430.283425908867, 8537.060923298432, 8570.614322355508, 8193.385496087818, 8281.21328473794, 8283.710070147636, 8399.790005249917, 8429.241368276884, 4692.436907571113, 4696.03731235096, 4723.645726570521, 4815.3258543803195, 4883.755812209375, 1887.169645356039, 1952.1410579345043, 1953.45303315072, 1967.5081229692578, 2030.8883011434514, 875.4747151709051, 983.6901376066517, 1062.7449412141184, 1085.630885498934, 1105.1379923659558, 18912.90543547301, 18925.43223703291, 19727.704084438745, 19779.307724229584, 19860.50348741293, 971.1890571372842, 1012.2610494339026, 1034.6585626743156, 1058.4866339825178, 1068.9144868410508, 10526.894731052591, 11114.666560003052, 11166.05088567481, 11196.66410007701, 11218.831717524243, 477486.0, 488759.6686049712, 494821.0, 511225.0, 513016.0, 91819.54090229506, 91977.54011229902, 92048.0, 92102.0, 93445.5327723357, 988.3921388346115, 995.6117114325419, 1011.1809434358047, 1030.8711411073616, 1032.0969151992008, 17204.91397543004, 17350.255224118537, 17612.91193544024, 17668.293268269124, 17750.112494375488, 40373.78878633646, 40380.192396151324, 41016.58983410247, 41593.0, 42000.1599968005, 56119.438805613056, 57449.13826292693, 57585.712071439375, 58036.0, 58083.0, 8030.63862126194, 8265.173482651686, 8321.542315172723, 8346.374021948257, 8488.787780305542, 12139.332336721565, 13063.608091757262, 13129.868701313248, 13223.140495867738, 13246.271455070064, 11376.488058037574, 11656.708582285512, 11700.824487632523, 11753.588624398106, 12124.636260912186, 6114.7248373822395, 10690.62582809598, 11307.886921131012, 11511.30932144074, 11664.591739289084, 11448.885511144781, 11772.352520611106, 11916.344601047025, 11919.702007449883, 12076.75846483083, 7399.8150046249275, 7622.0, 7654.272844079804, 8253.752387428147, 8475.83048339042, 8904.73285801427, 11760.365722946184, 12043.939780301042, 12120.878791211975, 12154.149209555246], "value": 9130.705807197606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.6615679923218, 1520.5058356034292, 1550.3720992997833, 1707.590178357194, 1856.387392160587, 8413.663453461862, 8706.303495720344, 8717.171868672474, 8770.122987701234, 8926.241269492084, 8476.957615211932, 8771.29829613631, 8981.820363592724, 8992.0, 8992.460452372863, 2313.5719891820027, 2353.446939969106, 2356.081128359941, 2359.516299158677, 2361.244401791427, 2269.4553307206234, 2317.8493397929083, 2348.8942997565064, 2351.0830775997374, 2354.0, 2290.977090229093, 2298.2415802785126, 2305.101010605865, 2342.7891489765916, 2350.6944097267415, 2244.494988627562, 2246.4945387287894, 2280.315905228433, 2280.350100221437, 2290.095412312144, 2298.896529665753, 2322.6516022596575, 2323.848949818256, 2325.232673217834, 2328.115316179858, 8346.791330216793, 8394.202550757669, 8434.325253979667, 8607.35444841633, 8916.509591972439, 5217.713025783581, 5330.147176451749, 5343.973280133574, 5344.412114667383, 5351.866203344908, 3406.7785593936314, 3460.9826950865086, 3517.103138699641, 3520.137566296248, 3589.0489020409614, 1164.9242799218023, 1171.9414029298587, 1246.7257203415234, 1260.3887114749339, 2195.110980053081, 12677.049221308347, 12880.291583962879, 12899.871001289961, 12905.483780648763, 12907.419166137452, 4654.418197725285, 4672.229082201398, 4689.742064186435, 4760.119377915097, 4770.880727981828, 10749.0, 10827.0, 10831.458427078614, 10831.67504974852, 10831.83752243717, 5292.967871265067, 5299.12564426873, 5301.045811753921, 5302.602304827154, 5305.045091883421, 4227.239096962515, 4301.935470967938, 4833.95166048335, 4861.6353773467135, 4863.5622793948005, 4143.647789937889, 4157.482822272097, 4186.5604111568455, 4186.769727664947, 4211.936820947688, 1261.0542093429929, 1289.2071376103816, 1291.7158225190442, 1305.8628843971246, 1315.0794443889124, 790.6797746912509, 969.8254314223508, 1007.0533698323552, 1020.285799940045, 1024.3085917005992, 5839.766409343663, 5947.791827286111, 6006.789762358297, 6252.781152659726, 6264.248290205113, 482.77857021735065, 494.0859410091374, 501.59120316941573, 506.1446155996428, 666.3702800853245, 4078.1843631273864, 4223.408722778813, 4239.512456067591, 4253.191893540217, 4254.425652536868, 10991.780164396827, 11177.49701263445, 11293.548258069584, 11317.49071291794, 11417.942910285396, 11078.944605276922, 11180.720481988015, 11183.32900026001, 11193.832092518618, 11264.0, 7840.725574604976, 8030.678772849021, 8037.276645101969, 8452.112528184452, 8573.957130214309, 5976.402359763989, 5989.490893274121, 6159.4456498915315, 6281.937180628135, 6285.59143655661, 10100.747481313027, 10375.948120259653, 10611.840822387516, 10613.20400969915, 10617.256792024484, 9201.355905086848, 10628.89371106279, 10732.624358147428, 10742.086922611354, 10769.892301076889, 7778.49439786412, 7929.207079292025, 7955.164707705608, 8199.590020498832, 8204.261616454547, 8116.959415203122, 8373.49759014461, 8398.664053437795, 8663.523506207219, 8801.47191168532, 7601.809954751176, 7672.232776722283, 7773.611319433892, 7882.763517094496, 7915.683372665029, 7892.36861051103, 7934.365250780039, 7946.053216961881, 7956.880646790187, 8079.313258373104, 7214.0, 7326.816829579303, 7354.705811767683, 7363.521371110861, 7372.447066470144, 5157.613179011664, 5197.194434862602, 5204.0, 5229.739606899392, 5319.202119682079, 5055.51972562606, 5219.399769026611, 5223.758589426718, 5445.646033007842, 5492.093804522209], "value": 4665.6446101486945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.2957837125879, 324.84569829331053, 325.0621955657926, 325.2795058944438, 337.1873784180125, 5357.946420535794, 5361.51746342829, 5384.738409867855, 5393.514583687473, 5461.2354270402075, 5328.227407025979, 5339.22581225722, 5360.169173778061, 5377.193420986854, 5384.111621582444, 3976.383660532622, 4015.297322968469, 4132.5454200037975, 4134.813933373005, 4158.147579746144, 4122.340425531916, 4139.648129908961, 4150.360607560012, 4192.140611174702, 4217.641500472449, 3965.2267807777353, 4137.2552940470705, 4143.4199212110325, 4149.174363280162, 4156.6051225133715, 4021.959780402188, 4137.069159439132, 4137.275976704064, 4137.524184718735, 4140.67498400512, 3647.5805282392334, 3649.434337677664, 3653.2876089162623, 3668.981655091734, 3673.412254039341, 5094.439611642753, 5110.514501122388, 5134.614903882224, 5134.691918484903, 5141.711938187508, 4384.868453946387, 4665.650076244296, 4671.6262698984, 4696.802315409549, 4706.247000479907, 5550.8057217997175, 5559.666420014772, 5569.749361278752, 5579.581531385122, 5580.246666699984, 3935.0949281665376, 3940.763554186758, 3952.426898099788, 3952.7035472339403, 3955.5253369595835, 5482.91775623366, 5637.46444087811, 5659.886802263932, 5682.516986056232, 5719.170720245583, 4001.4998125234347, 4031.7580945143386, 4033.495813023372, 4033.757974521538, 4037.414574886625, 4076.7769669099152, 4078.632923036941, 4120.1553681495225, 4126.319157339066, 4128.731632443882, 4596.126735920231, 4714.0, 4722.197226471508, 4732.503087175865, 4742.976285118552, 5440.292761941001, 5472.5621950243885, 5533.972330138324, 5558.805441809517, 5576.776928922797, 1392.2829742682527, 1403.933010911694, 1411.6329754263966, 1411.8517555656508, 1413.9505117320844, 898.725888603969, 915.7115508614766, 937.4937533731845, 954.174638937328, 959.769655282741, 5226.372835259717, 5302.416734159239, 5316.521513063843, 5338.359396872323, 5342.305500285016, 5619.314205738262, 5630.774769009194, 5663.178839068312, 5670.829875103754, 5682.374938756816, 5097.470758772353, 5183.196604526304, 5216.869578260498, 5217.243499692523, 5364.570834333322, 2942.3379739558854, 3005.8947936822105, 3017.2456885778556, 3021.425929073469, 3027.1826606816035, 5626.831195064155, 5742.827715168552, 5772.604369186824, 5823.30120385548, 5880.7353669085, 5807.477327040587, 5815.941840581625, 5821.388754180834, 5821.565276486893, 5822.621529600562, 5894.705264736746, 5928.851778705567, 5929.6145750526075, 5974.761009559656, 5994.9700251499335, 5494.890102198014, 5706.400827913009, 5722.713864306851, 5728.283964504437, 5770.451807078321, 5598.664080155041, 5618.6628802272, 5620.718964051699, 5645.379008309001, 5647.915281270702, 5652.26520552342, 5932.436418540232, 5980.910286345796, 5982.970085149721, 5997.760089596367, 4071.1450595374117, 4077.4291599175544, 4084.1627466368727, 4088.509378874554, 4092.3247664135083, 5702.51734549012, 5709.400512946247, 5731.369549349485, 5733.39799321082, 5767.855803604775, 5332.813351532833, 5574.275344205227, 5600.159976003632, 5641.746121424628, 5654.604177707685, 5519.93002624016, 5541.16882467617, 5542.140968149944, 5542.972285138549, 5553.222548843084, 5310.522053015247, 5336.626436149432, 5449.918251226156, 5460.972695136657, 5519.69641669712, 5570.108782594765, 5577.163425486209, 5594.608377413542, 5605.691686957257, 5606.495415412633, 5439.0, 5463.562914966873, 5476.028629693227, 5478.986387518322, 5501.834944951658], "value": 4228.329697848223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.2696357569579, 765.0, 812.8008637883719, 835.4945258118838, 884.654984556023, 15156.1664108474, 15819.920900395482, 16252.918735406322, 16323.347066117356, 16364.427245046425, 16531.91734041331, 16570.83429165708, 16646.0, 16701.66596668066, 16721.331146754113, 682.604089628017, 795.308081968688, 810.9189081091903, 818.2840014986872, 824.4599787139433, 807.4953154278576, 809.3565615335792, 812.3338862133053, 812.7764864662206, 812.8333691593209, 846.5132548784474, 848.1094850407048, 848.8429640516524, 850.5067061104576, 854.8803167556547, 690.520088538466, 811.1037303779357, 843.0, 855.5166331023014, 857.3098655582254, 629.6851574212893, 632.1118828046602, 632.2413104274889, 632.2823595219413, 632.3360471504901, 14524.636884077878, 14537.200453975027, 14577.635559111, 14584.854151458456, 14604.0, 13666.248356340397, 14077.577672669837, 14108.365123569463, 14262.572122836227, 14455.421783128768, 12646.832802722607, 12655.683607909783, 12786.041046921426, 12913.612591622266, 12931.030172737082, 4432.650695131585, 4446.088551846864, 4480.955190448087, 4525.162844873676, 4577.176108300505, 77906.0, 79372.20627793706, 80803.0, 81136.9999999994, 81481.59259203725, 11332.71668208285, 11335.206535542433, 11476.368799715929, 11555.191136620524, 11720.589779357682, 20806.687899681518, 20826.583468330547, 20860.06129724166, 20864.330853531683, 21430.249941251983, 8058.194180581895, 8289.378296627656, 8419.452735572168, 8459.492430454193, 8727.345449091217, 4729.07782982322, 4774.594159496412, 4828.8792780180775, 4848.418189817174, 4882.633802464829, 3630.2013557017412, 3772.5472943246436, 3775.716821238418, 3779.1874746929543, 3787.696984241254, 640.6348381422638, 643.4562794438692, 648.6043513456788, 658.0622612776774, 661.3056290894541, 670.6981858163846, 708.1961973160397, 731.378328420838, 792.3621484704753, 801.6232370785722, 10143.239257055602, 10355.0, 10403.53184106717, 10452.68641940743, 10457.111145552713, 646.7994921574327, 733.9302766237199, 755.4787196834167, 756.4100001998451, 761.6534476813036, 4495.483019452805, 5006.2156714162675, 5214.165733482625, 5347.866303342447, 5349.117395629755, 122688.0, 123931.38034309771, 124064.0, 128450.0, 128758.0, 104962.0, 105821.47089264658, 106153.0, 106234.0, 106955.46522267339, 94408.0, 95481.99999999862, 96251.51874240584, 98430.5078474603, 100231.0, 10256.333338332985, 10417.84373234387, 10439.928041509855, 10440.321379110334, 10545.156387488829, 45512.0, 56126.43873561212, 57155.42844571501, 57697.134542981046, 58260.41739582719, 73757.0, 74399.25600743924, 75559.62220188863, 75644.62177689077, 76567.0, 14337.354819033377, 14398.928005359907, 14454.132752034911, 14533.200673963034, 14823.40706371733, 14173.362198700877, 14594.197319147548, 14812.0, 15657.608559786097, 16004.359825606845, 13518.72962540724, 14536.345864435914, 14767.92616036913, 14775.92612036933, 15015.24923753786, 13662.521811736542, 13911.0, 14253.358598863284, 14417.7837332438, 14625.34185961613, 13419.932900335436, 13646.590602281947, 13675.726485470434, 13724.862751372359, 14003.299835008005, 11616.767664646492, 11819.468123934272, 11875.228110172811, 12433.12968092225, 12582.87417125817, 10722.7340326784, 11762.882371176178, 11823.704407389883, 11915.2255103418, 12112.273263604213], "value": 7876.94198429174, "unit": "score"}], "name": "dromaeo_css", "value": 7381.649539227772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 109.0, 111.0, 110.0, 109.0, 111.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 134.0, 181.0, 127.0, 131.0, 149.0, 129.0, 183.0, 128.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 127.0, 75.0, 75.0, 73.0, 74.0, 100.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 84.0, 84.0, 86.0, 120.0, 85.0, 86.0, 134.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 81.0, 111.0, 79.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 124.0, 125.0, 121.0, 118.0, 140.0, 124.0, 139.0, 123.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 164.0, 161.0, 159.0, 164.0, 162.0, 159.0, 158.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 64.0, 62.0, 65.0, 63.0, 63.0, 65.0, 63.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1503.0, "alertThreshold": 2.0}]} 11:56:31 INFO - Return code: 0 11:56:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:31 ERROR - # TBPL SUCCESS # 11:56:31 INFO - Running post-action listener: _resource_record_post_action 11:56:31 INFO - ##### 11:56:31 INFO - ##### Finished run-tests step (success) 11:56:31 INFO - ##### 11:56:31 INFO - Running post-run listener: _resource_record_post_run 11:56:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302788608; Read time: 12; Write time: 195656 11:56:31 INFO - TinderboxPrint: CPU usage
13.1% 11:56:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:56:31 INFO - TinderboxPrint: I/O write bytes / time
302,788,608 / 195,656 11:56:31 INFO - TinderboxPrint: CPU idle
8,265.0 (86.9%) 11:56:31 INFO - TinderboxPrint: CPU user
1,207.1 (12.7%) 11:56:31 INFO - TinderboxPrint: Swap in / out
0 / 0 11:56:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14123008; Read time: 0; Write time: 2760 11:56:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288665600; Read time: 12; Write time: 192896 11:56:31 INFO - Running post-run listener: _upload_blobber_files 11:56:31 INFO - Blob upload gear active. 11:56:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:31 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 11:56:31 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'] 11:56:31 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 11:56:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:56:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:33 INFO - (blobuploader) - INFO - Done attempting. 11:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:36 INFO - (blobuploader) - INFO - Done attempting. 11:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:37 INFO - (blobuploader) - INFO - Done attempting. 11:56:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:37 INFO - Return code: 0 11:56:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487a18cd5652c4f9995d01f5e7176c5ecc8a907c1053dcef01047a7cc591593c25a1fd9c5b5cd899db2ff11af446129a7673d5e8ec5f5ec3381b4a169495080c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/557fb33ba3dc4e0ca6c3eff4e2ba38106e2cbfbe393f44bcbc64709ec85874e3998b75abe06a1b9c219c56dcfdcde51f84d2af79cc14435db9779da7870f9ed1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e41fcea5437e88b73fe9dd12a2b0de223df3fe43579ef13d32815e768024e8d8140ae06e4b64e52b1e4d8915c149b631bd154aabf8c836765d67a671ee41fe7"} 11:56:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:37 INFO - Contents: 11:56:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487a18cd5652c4f9995d01f5e7176c5ecc8a907c1053dcef01047a7cc591593c25a1fd9c5b5cd899db2ff11af446129a7673d5e8ec5f5ec3381b4a169495080c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/557fb33ba3dc4e0ca6c3eff4e2ba38106e2cbfbe393f44bcbc64709ec85874e3998b75abe06a1b9c219c56dcfdcde51f84d2af79cc14435db9779da7870f9ed1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e41fcea5437e88b73fe9dd12a2b0de223df3fe43579ef13d32815e768024e8d8140ae06e4b64e52b1e4d8915c149b631bd154aabf8c836765d67a671ee41fe7"} 11:56:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:37 INFO - Copying logs to upload dir... 11:56:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.242111 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-06 11:56:37.123145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:56:37.127023) ========= 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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 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/487a18cd5652c4f9995d01f5e7176c5ecc8a907c1053dcef01047a7cc591593c25a1fd9c5b5cd899db2ff11af446129a7673d5e8ec5f5ec3381b4a169495080c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/557fb33ba3dc4e0ca6c3eff4e2ba38106e2cbfbe393f44bcbc64709ec85874e3998b75abe06a1b9c219c56dcfdcde51f84d2af79cc14435db9779da7870f9ed1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e41fcea5437e88b73fe9dd12a2b0de223df3fe43579ef13d32815e768024e8d8140ae06e4b64e52b1e4d8915c149b631bd154aabf8c836765d67a671ee41fe7"} build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487a18cd5652c4f9995d01f5e7176c5ecc8a907c1053dcef01047a7cc591593c25a1fd9c5b5cd899db2ff11af446129a7673d5e8ec5f5ec3381b4a169495080c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/557fb33ba3dc4e0ca6c3eff4e2ba38106e2cbfbe393f44bcbc64709ec85874e3998b75abe06a1b9c219c56dcfdcde51f84d2af79cc14435db9779da7870f9ed1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e41fcea5437e88b73fe9dd12a2b0de223df3fe43579ef13d32815e768024e8d8140ae06e4b64e52b1e4d8915c149b631bd154aabf8c836765d67a671ee41fe7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:56:37.152197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:56:37.152533) ========= 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=6dbc10da6d83fee962c624be000001a8-1465238123.236600-1936787828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:56:37.237411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:56:37.237738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:56:37.238012) ========= ========= Total master_lag: 0.16 =========