builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1467891217.78 results: success (0) buildid: 20160706164923 builduid: cf5d7723f75c49b7843667d4b06ac06d revision: c1342bdc08a949c74278e59958dbecbc6f138258 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.780359) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.780928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.781259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.796714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.797069) ========= 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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 04:33:38-- 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.1M=0s 2016-07-07 04:33:38 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.925280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.925713) ========= 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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.976419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:37.976805) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c1342bdc08a949c74278e59958dbecbc6f138258 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c1342bdc08a949c74278e59958dbecbc6f138258 --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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 04:33:38,354 truncating revision to first 12 chars 2016-07-07 04:33:38,354 Setting DEBUG logging. 2016-07-07 04:33:38,354 attempt 1/10 2016-07-07 04:33:38,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c1342bdc08a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 04:33:38,673 unpacking tar archive at: mozilla-aurora-c1342bdc08a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:38.651038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:38.651426) ========= script_repo_revision: c1342bdc08a949c74278e59958dbecbc6f138258 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:38.651890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:38.652195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:38.662418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-07 04:33:38.662760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:39 INFO - MultiFileLogger online at 20160707 04:33:39 in /builds/slave/test 04:33:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:33:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:39 INFO - {'append_to_log': False, 04:33:39 INFO - 'base_work_dir': '/builds/slave/test', 04:33:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:33:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:39 INFO - 'branch': 'Mozilla-Aurora', 04:33:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:39 INFO - 'config_files': ('talos/linux_config.py',), 04:33:39 INFO - 'default_actions': ('clobber', 04:33:39 INFO - 'read-buildbot-config', 04:33:39 INFO - 'download-and-extract', 04:33:39 INFO - 'populate-webroot', 04:33:39 INFO - 'create-virtualenv', 04:33:39 INFO - 'install', 04:33:39 INFO - 'run-tests'), 04:33:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:39 INFO - 'download_minidump_stackwalk': True, 04:33:39 INFO - 'download_symbols': 'ondemand', 04:33:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:39 INFO - 'installer_path': 'installer.exe', 04:33:39 INFO - 'log_level': 'info', 04:33:39 INFO - 'log_name': 'talos', 04:33:39 INFO - 'log_to_console': True, 04:33:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:39 INFO - 'opt_config_files': (), 04:33:39 INFO - 'pip_index': False, 04:33:39 INFO - 'sps_profile': False, 04:33:39 INFO - 'sps_profile_interval': 0, 04:33:39 INFO - 'suite': 'dromaeojs-e10s', 04:33:39 INFO - 'system_bits': '32', 04:33:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:39 INFO - 'title': 'talos-linux64-ix-054', 04:33:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:39 INFO - 'use_talos_json': True, 04:33:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:39 INFO - 'work_dir': 'build'} 04:33:39 INFO - ##### 04:33:39 INFO - ##### Running clobber step. 04:33:39 INFO - ##### 04:33:39 INFO - Running pre-action listener: _resource_record_pre_action 04:33:39 INFO - Running main action method: clobber 04:33:39 INFO - rmtree: /builds/slave/test/build 04:33:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:39 INFO - Running post-action listener: _resource_record_post_action 04:33:39 INFO - ##### 04:33:39 INFO - ##### Finished clobber step (success) 04:33:39 INFO - ##### 04:33:39 INFO - ##### 04:33:39 INFO - ##### Running read-buildbot-config step. 04:33:39 INFO - ##### 04:33:39 INFO - Running pre-action listener: _resource_record_pre_action 04:33:39 INFO - Running main action method: read_buildbot_config 04:33:39 INFO - Using buildbot properties: 04:33:39 INFO - { 04:33:39 INFO - "project": "", 04:33:39 INFO - "product": "firefox", 04:33:39 INFO - "script_repo_revision": "production", 04:33:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:33:39 INFO - "repository": "", 04:33:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:33:39 INFO - "buildid": "20160706164923", 04:33:39 INFO - "pgo_build": "True", 04:33:39 INFO - "basedir": "/builds/slave/test", 04:33:39 INFO - "buildnumber": 390, 04:33:39 INFO - "slavename": "talos-linux64-ix-054", 04:33:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:33:39 INFO - "platform": "ubuntu64_hw", 04:33:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:33:39 INFO - "branch": "mozilla-aurora", 04:33:39 INFO - "repo_path": "releases/mozilla-aurora", 04:33:39 INFO - "revision": "c1342bdc08a949c74278e59958dbecbc6f138258", 04:33:39 INFO - "stage_platform": "linux64-pgo", 04:33:39 INFO - "builduid": "cf5d7723f75c49b7843667d4b06ac06d", 04:33:39 INFO - "slavebuilddir": "test" 04:33:39 INFO - } 04:33:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:33:39 INFO - Running post-action listener: _resource_record_post_action 04:33:39 INFO - ##### 04:33:39 INFO - ##### Finished read-buildbot-config step (success) 04:33:39 INFO - ##### 04:33:39 INFO - ##### 04:33:39 INFO - ##### Running download-and-extract step. 04:33:39 INFO - ##### 04:33:39 INFO - Running pre-action listener: _resource_record_pre_action 04:33:39 INFO - Running main action method: download_and_extract 04:33:39 INFO - mkdir: /builds/slave/test/build/tests 04:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:39 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:33:40 INFO - Downloaded 1361 bytes. 04:33:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:40 INFO - Using the following test package requirements: 04:33:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:33:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:33:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'jsshell-linux-x86_64.zip'], 04:33:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:33:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:33:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:33:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:40 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:41 INFO - Downloaded 24526649 bytes. 04:33:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:33:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:33:43 INFO - Return code: 0 04:33:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:33: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')]} 04:33:43 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:45 INFO - Downloaded 24526649 bytes. 04:33:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:33:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:33:47 INFO - Return code: 0 04:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:47 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:33:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:33:48 INFO - Downloaded 10833369 bytes. 04:33:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:33:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:33:48 INFO - Return code: 0 04:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:48 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:33:49 INFO - Downloaded 63634791 bytes. 04:33:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:49 INFO - mkdir: /builds/slave/test/properties 04:33:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:49 INFO - Contents: 04:33:49 INFO - build_url:https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:50 INFO - Running post-action listener: _resource_record_post_action 04:33:50 INFO - Running post-action listener: set_extra_try_arguments 04:33:50 INFO - ##### 04:33:50 INFO - ##### Finished download-and-extract step (success) 04:33:50 INFO - ##### 04:33:50 INFO - ##### 04:33:50 INFO - ##### Running populate-webroot step. 04:33:50 INFO - ##### 04:33:50 INFO - Running pre-action listener: _resource_record_pre_action 04:33:50 INFO - Running main action method: populate_webroot 04:33:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:50 INFO - '--tppagecycles', 04:33:50 INFO - '7'], 04:33:50 INFO - 'tests': ['tsvgm']}}, 04:33:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['damp', 'tps']}, 04:33:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'tests': ['damp', 'tps']}, 04:33:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['dromaeo_dom']}, 04:33:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['a11yr', 04:33:50 INFO - 'ts_paint', 04:33:50 INFO - 'tpaint', 04:33:50 INFO - 'sessionrestore', 04:33:50 INFO - 'sessionrestore_no_auto_restore', 04:33:50 INFO - 'tabpaint']}, 04:33:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['tsvgx', 04:33:50 INFO - 'tsvgr_opacity', 04:33:50 INFO - 'tart', 04:33:50 INFO - 'tscrollx', 04:33:50 INFO - 'cart']}, 04:33:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:50 INFO - 'tsvgr_opacity', 04:33:50 INFO - 'tart', 04:33:50 INFO - 'tscrollx', 04:33:50 INFO - 'cart']}, 04:33:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'talos_options': ['--disable-e10s'], 04:33:50 INFO - 'tests': ['tp5o']}, 04:33:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'tests': ['tp5o']}, 04:33:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'talos_options': ['--disable-e10s', 04:33:50 INFO - '--xperf_path', 04:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:50 INFO - 'tests': ['tp5n']}, 04:33:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:50 INFO - 'talos_options': ['--xperf_path', 04:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:50 INFO - 'tests': ['tp5n']}}, 04:33:50 INFO - 'talos.zip': {'path': '', 04:33:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:50 INFO - Running post-action listener: _resource_record_post_action 04:33:50 INFO - ##### 04:33:50 INFO - ##### Finished populate-webroot step (success) 04:33:50 INFO - ##### 04:33:50 INFO - ##### 04:33:50 INFO - ##### Running create-virtualenv step. 04:33:50 INFO - ##### 04:33:50 INFO - Running pre-action listener: _resource_record_pre_action 04:33:50 INFO - Running main action method: create_virtualenv 04:33:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:33:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:50 INFO - Using real prefix '/usr' 04:33:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:52 INFO - Installing pip.................done. 04:33:53 INFO - Return code: 0 04:33:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:33:53 INFO - Using env: {'DISPLAY': ':0', 04:33:53 INFO - 'HOME': '/home/cltbld', 04:33:53 INFO - 'LANG': 'en_US.UTF-8', 04:33:53 INFO - 'LANGUAGE': 'en_US:en', 04:33:53 INFO - 'LOGNAME': 'cltbld', 04:33:53 INFO - 'MAIL': '/var/mail/cltbld', 04:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:53 INFO - 'MOZ_NO_REMOTE': '1', 04:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:53 INFO - 'NO_EM_RESTART': '1', 04:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:53 INFO - 'PWD': '/builds/slave/test', 04:33:53 INFO - 'SHELL': '/bin/bash', 04:33:53 INFO - 'SHLVL': '1', 04:33:53 INFO - 'TERM': 'linux', 04:33:53 INFO - 'TMOUT': '86400', 04:33:53 INFO - 'USER': 'cltbld', 04:33:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:53 INFO - '_': '/tools/buildbot/bin/python'} 04:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:33:53 INFO - Cleaning up... 04:33:53 INFO - Return code: 0 04:33:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:33:53 INFO - Using env: {'DISPLAY': ':0', 04:33:53 INFO - 'HOME': '/home/cltbld', 04:33:53 INFO - 'LANG': 'en_US.UTF-8', 04:33:53 INFO - 'LANGUAGE': 'en_US:en', 04:33:53 INFO - 'LOGNAME': 'cltbld', 04:33:53 INFO - 'MAIL': '/var/mail/cltbld', 04:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:53 INFO - 'MOZ_NO_REMOTE': '1', 04:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:53 INFO - 'NO_EM_RESTART': '1', 04:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:53 INFO - 'PWD': '/builds/slave/test', 04:33:53 INFO - 'SHELL': '/bin/bash', 04:33:53 INFO - 'SHLVL': '1', 04:33:53 INFO - 'TERM': 'linux', 04:33:53 INFO - 'TMOUT': '86400', 04:33:53 INFO - 'USER': 'cltbld', 04:33:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:53 INFO - '_': '/tools/buildbot/bin/python'} 04:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:53 INFO - Downloading/unpacking psutil>=3.1.1 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:55 INFO - Installing collected packages: psutil 04:33:55 INFO - Running setup.py install for psutil 04:33:55 INFO - building 'psutil._psutil_linux' extension 04:33:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:33:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:33:55 INFO - building 'psutil._psutil_posix' extension 04:33:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:33:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:55 INFO - Successfully installed psutil 04:33:55 INFO - Cleaning up... 04:33:55 INFO - Return code: 0 04:33:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:33:55 INFO - Using env: {'DISPLAY': ':0', 04:33:55 INFO - 'HOME': '/home/cltbld', 04:33:55 INFO - 'LANG': 'en_US.UTF-8', 04:33:55 INFO - 'LANGUAGE': 'en_US:en', 04:33:55 INFO - 'LOGNAME': 'cltbld', 04:33:55 INFO - 'MAIL': '/var/mail/cltbld', 04:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:55 INFO - 'MOZ_NO_REMOTE': '1', 04:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:55 INFO - 'NO_EM_RESTART': '1', 04:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:55 INFO - 'PWD': '/builds/slave/test', 04:33:55 INFO - 'SHELL': '/bin/bash', 04:33:55 INFO - 'SHLVL': '1', 04:33:55 INFO - 'TERM': 'linux', 04:33:55 INFO - 'TMOUT': '86400', 04:33:55 INFO - 'USER': 'cltbld', 04:33:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:55 INFO - '_': '/tools/buildbot/bin/python'} 04:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:33:58 INFO - Installing collected packages: mozsystemmonitor 04:33:58 INFO - Running setup.py install for mozsystemmonitor 04:33:58 INFO - Successfully installed mozsystemmonitor 04:33:58 INFO - Cleaning up... 04:33:58 INFO - Return code: 0 04:33:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:58 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:33:58 INFO - Using env: {'DISPLAY': ':0', 04:33:58 INFO - 'HOME': '/home/cltbld', 04:33:58 INFO - 'LANG': 'en_US.UTF-8', 04:33:58 INFO - 'LANGUAGE': 'en_US:en', 04:33:58 INFO - 'LOGNAME': 'cltbld', 04:33:58 INFO - 'MAIL': '/var/mail/cltbld', 04:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:58 INFO - 'MOZ_NO_REMOTE': '1', 04:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:58 INFO - 'NO_EM_RESTART': '1', 04:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:58 INFO - 'PWD': '/builds/slave/test', 04:33:58 INFO - 'SHELL': '/bin/bash', 04:33:58 INFO - 'SHLVL': '1', 04:33:58 INFO - 'TERM': 'linux', 04:33:58 INFO - 'TMOUT': '86400', 04:33:58 INFO - 'USER': 'cltbld', 04:33:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:58 INFO - '_': '/tools/buildbot/bin/python'} 04:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:00 INFO - warning: no files found matching '*.txt' 04:34:00 INFO - no previously-included directories found matching 'build' 04:34:00 INFO - no previously-included directories found matching 'dist' 04:34:00 INFO - no previously-included directories found matching '.git*' 04:34:00 INFO - Installing collected packages: jsonschema, functools32 04:34:00 INFO - Running setup.py install for functools32 04:34:00 INFO - warning: no files found matching '*.txt' 04:34:00 INFO - no previously-included directories found matching 'build' 04:34:00 INFO - no previously-included directories found matching 'dist' 04:34:00 INFO - no previously-included directories found matching '.git*' 04:34:00 INFO - Successfully installed jsonschema functools32 04:34:00 INFO - Cleaning up... 04:34:00 INFO - Return code: 0 04:34:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:00 INFO - Using env: {'DISPLAY': ':0', 04:34:00 INFO - 'HOME': '/home/cltbld', 04:34:00 INFO - 'LANG': 'en_US.UTF-8', 04:34:00 INFO - 'LANGUAGE': 'en_US:en', 04:34:00 INFO - 'LOGNAME': 'cltbld', 04:34:00 INFO - 'MAIL': '/var/mail/cltbld', 04:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:00 INFO - 'MOZ_NO_REMOTE': '1', 04:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:00 INFO - 'NO_EM_RESTART': '1', 04:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:00 INFO - 'PWD': '/builds/slave/test', 04:34:00 INFO - 'SHELL': '/bin/bash', 04:34:00 INFO - 'SHLVL': '1', 04:34:00 INFO - 'TERM': 'linux', 04:34:00 INFO - 'TMOUT': '86400', 04:34:00 INFO - 'USER': 'cltbld', 04:34:00 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:00 INFO - '_': '/tools/buildbot/bin/python'} 04:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - Downloading docopt-0.6.1.tar.gz 04:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:03 INFO - Running setup.py install for blobuploader 04:34:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:03 INFO - Running setup.py install for requests 04:34:04 INFO - Running setup.py install for docopt 04:34:04 INFO - Successfully installed blobuploader requests docopt 04:34:04 INFO - Cleaning up... 04:34:04 INFO - Return code: 0 04:34:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:04 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:04 INFO - Using env: {'DISPLAY': ':0', 04:34:04 INFO - 'HOME': '/home/cltbld', 04:34:04 INFO - 'LANG': 'en_US.UTF-8', 04:34:04 INFO - 'LANGUAGE': 'en_US:en', 04:34:04 INFO - 'LOGNAME': 'cltbld', 04:34:04 INFO - 'MAIL': '/var/mail/cltbld', 04:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:04 INFO - 'MOZ_NO_REMOTE': '1', 04:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:04 INFO - 'NO_EM_RESTART': '1', 04:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:04 INFO - 'PWD': '/builds/slave/test', 04:34:04 INFO - 'SHELL': '/bin/bash', 04:34:04 INFO - 'SHLVL': '1', 04:34:04 INFO - 'TERM': 'linux', 04:34:04 INFO - 'TMOUT': '86400', 04:34:04 INFO - 'USER': 'cltbld', 04:34:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:04 INFO - '_': '/tools/buildbot/bin/python'} 04:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:04 INFO - Running setup.py (path:/tmp/pip-KvXkVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:04 INFO - Running setup.py (path:/tmp/pip-moNAei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:04 INFO - Running setup.py (path:/tmp/pip-1hCnEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:04 INFO - Running setup.py (path:/tmp/pip-eLc4im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:04 INFO - Running setup.py (path:/tmp/pip-YC6Szf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:04 INFO - Running setup.py (path:/tmp/pip-F8LoNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:04 INFO - Running setup.py (path:/tmp/pip-pixsF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:05 INFO - Running setup.py (path:/tmp/pip-LpxPya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:05 INFO - Running setup.py (path:/tmp/pip-Ls6GRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:05 INFO - Running setup.py (path:/tmp/pip-U5xret-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:05 INFO - Running setup.py (path:/tmp/pip-IEcD5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:05 INFO - Running setup.py (path:/tmp/pip-4mTaWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:05 INFO - Running setup.py (path:/tmp/pip-pNzMbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:05 INFO - Running setup.py (path:/tmp/pip-cbC958-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:05 INFO - Running setup.py (path:/tmp/pip-WOQHvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:05 INFO - Running setup.py (path:/tmp/pip-Hcn6pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:05 INFO - Running setup.py (path:/tmp/pip-eGrlJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:05 INFO - Running setup.py install for manifestparser 04:34:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:05 INFO - Running setup.py install for mozcrash 04:34:05 INFO - Running setup.py install for mozdebug 04:34:06 INFO - Running setup.py install for mozdevice 04:34:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozfile 04:34:06 INFO - Running setup.py install for mozhttpd 04:34:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozinfo 04:34:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozInstall 04:34:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozleak 04:34:06 INFO - Running setup.py install for mozlog 04:34:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for moznetwork 04:34:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozprocess 04:34:07 INFO - Running setup.py install for mozprofile 04:34:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozrunner 04:34:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozscreenshot 04:34:07 INFO - Running setup.py install for moztest 04:34:07 INFO - Running setup.py install for mozversion 04:34:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:07 INFO - Cleaning up... 04:34:07 INFO - Return code: 0 04:34:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:07 INFO - Using env: {'DISPLAY': ':0', 04:34:07 INFO - 'HOME': '/home/cltbld', 04:34:07 INFO - 'LANG': 'en_US.UTF-8', 04:34:07 INFO - 'LANGUAGE': 'en_US:en', 04:34:07 INFO - 'LOGNAME': 'cltbld', 04:34:07 INFO - 'MAIL': '/var/mail/cltbld', 04:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:07 INFO - 'MOZ_NO_REMOTE': '1', 04:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:07 INFO - 'NO_EM_RESTART': '1', 04:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:07 INFO - 'PWD': '/builds/slave/test', 04:34:07 INFO - 'SHELL': '/bin/bash', 04:34:07 INFO - 'SHLVL': '1', 04:34:07 INFO - 'TERM': 'linux', 04:34:07 INFO - 'TMOUT': '86400', 04:34:07 INFO - 'USER': 'cltbld', 04:34:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:07 INFO - '_': '/tools/buildbot/bin/python'} 04:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:07 INFO - Running setup.py (path:/tmp/pip-6iQAvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:07 INFO - Running setup.py (path:/tmp/pip-mDgW9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:07 INFO - Running setup.py (path:/tmp/pip-79tF6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:08 INFO - Running setup.py (path:/tmp/pip-4g0Fgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:08 INFO - Running setup.py (path:/tmp/pip-NA8qii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:08 INFO - Running setup.py (path:/tmp/pip-CR20FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:08 INFO - Running setup.py (path:/tmp/pip-IJzE2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:08 INFO - Running setup.py (path:/tmp/pip-lEodzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:08 INFO - Running setup.py (path:/tmp/pip-9ZIGlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:08 INFO - Running setup.py (path:/tmp/pip-E7eo1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:08 INFO - Running setup.py (path:/tmp/pip-WiWZrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:08 INFO - Running setup.py (path:/tmp/pip-Ni5kN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:08 INFO - Running setup.py (path:/tmp/pip-xTQHy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:08 INFO - Running setup.py (path:/tmp/pip-3s_tMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:08 INFO - Running setup.py (path:/tmp/pip-J8fZNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:08 INFO - Running setup.py (path:/tmp/pip-8AqOEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:08 INFO - Running setup.py (path:/tmp/pip-Tc6Cmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:10 INFO - Downloading blessings-1.6.tar.gz 04:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:11 INFO - Installing collected packages: blessings 04:34:11 INFO - Running setup.py install for blessings 04:34:11 INFO - Successfully installed blessings 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:11 INFO - Reading from file tmpfile_stdout 04:34:11 INFO - Current package versions: 04:34:11 INFO - argparse == 1.2.1 04:34:11 INFO - blessings == 1.6 04:34:11 INFO - blobuploader == 1.2.4 04:34:11 INFO - docopt == 0.6.1 04:34:11 INFO - functools32 == 3.2.3-2 04:34:11 INFO - jsonschema == 2.5.1 04:34:11 INFO - manifestparser == 1.1 04:34:11 INFO - mozInstall == 1.12 04:34:11 INFO - mozcrash == 0.17 04:34:11 INFO - mozdebug == 0.1 04:34:11 INFO - mozdevice == 0.48 04:34:11 INFO - mozfile == 1.2 04:34:11 INFO - mozhttpd == 0.7 04:34:11 INFO - mozinfo == 0.9 04:34:11 INFO - mozleak == 0.1 04:34:11 INFO - mozlog == 3.2 04:34:11 INFO - moznetwork == 0.27 04:34:11 INFO - mozprocess == 0.22 04:34:11 INFO - mozprofile == 0.28 04:34:11 INFO - mozrunner == 6.11 04:34:11 INFO - mozscreenshot == 0.1 04:34:11 INFO - mozsystemmonitor == 0.3 04:34:11 INFO - moztest == 0.7 04:34:11 INFO - mozversion == 1.4 04:34:11 INFO - psutil == 3.1.1 04:34:11 INFO - requests == 1.2.3 04:34:11 INFO - wsgiref == 0.1.2 04:34:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f0ddbb1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:12 INFO - Downloading/unpacking flake8 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:34:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:34:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:14 INFO - no previously-included directories found matching 'docs/_build' 04:34:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:34:14 INFO - Running setup.py install for pep8 04:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:14 INFO - no previously-included directories found matching 'docs/_build' 04:34:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:34:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:34:15 INFO - Cleaning up... 04:34:15 INFO - Return code: 0 04:34:15 INFO - Running post-action listener: _resource_record_post_action 04:34:15 INFO - Running post-action listener: _start_resource_monitoring 04:34:15 INFO - Starting resource monitoring. 04:34:15 INFO - ##### 04:34:15 INFO - ##### Finished create-virtualenv step (success) 04:34:15 INFO - ##### 04:34:15 INFO - ##### 04:34:15 INFO - ##### Running install step. 04:34:15 INFO - ##### 04:34:15 INFO - Running pre-action listener: _resource_record_pre_action 04:34:15 INFO - Running main action method: install 04:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:15 INFO - Reading from file tmpfile_stdout 04:34:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:15 INFO - Reading from file tmpfile_stdout 04:34:15 INFO - Output received: 04:34:15 INFO - Usage: mozinstall [options] installer 04:34:15 INFO - Options: 04:34:15 INFO - -h, --help show this help message and exit 04:34:15 INFO - -d DEST, --destination=DEST 04:34:15 INFO - Directory to install application into. [default: 04:34:15 INFO - "/builds/slave/test"] 04:34:15 INFO - --app=APP Application being installed. [default: firefox] 04:34:15 INFO - mkdir: /builds/slave/test/build/application 04:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:34:31 INFO - Reading from file tmpfile_stdout 04:34:31 INFO - Output received: 04:34:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:31 INFO - Running post-action listener: _resource_record_post_action 04:34:31 INFO - ##### 04:34:31 INFO - ##### Finished install step (success) 04:34:31 INFO - ##### 04:34:31 INFO - ##### 04:34:31 INFO - ##### Running run-tests step. 04:34:31 INFO - ##### 04:34:31 INFO - Running pre-action listener: _resource_record_pre_action 04:34:31 INFO - Running main action method: run_tests 04:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:31 INFO - Python 2.7.3 04:34:31 INFO - Return code: 0 04:34:31 INFO - grabbing minidump binary from tooltool 04:34: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')]} 04:34:31 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 0x1c151c0>, '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 0x1c160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:34:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:34:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:34:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:31 INFO - Return code: 0 04:34:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:34:32 INFO - Return code: 0 04:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:34:32 INFO - Using env: {'DISPLAY': ':0', 04:34:32 INFO - 'HOME': '/home/cltbld', 04:34:32 INFO - 'LANG': 'en_US.UTF-8', 04:34:32 INFO - 'LANGUAGE': 'en_US:en', 04:34:32 INFO - 'LOGNAME': 'cltbld', 04:34:32 INFO - 'MAIL': '/var/mail/cltbld', 04:34:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:32 INFO - 'MOZ_NO_REMOTE': '1', 04:34:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:32 INFO - 'NO_EM_RESTART': '1', 04:34:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:32 INFO - 'PWD': '/builds/slave/test', 04:34:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:32 INFO - 'SHELL': '/bin/bash', 04:34:32 INFO - 'SHLVL': '1', 04:34:32 INFO - 'TERM': 'linux', 04:34:32 INFO - 'TMOUT': '86400', 04:34:32 INFO - 'USER': 'cltbld', 04:34:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271', 04:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:32 INFO - '_': '/tools/buildbot/bin/python'} 04:34:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:34:32 INFO - mozversion application_buildid: 20160706164923 04:34:32 INFO - mozversion application_changeset: c1342bdc08a949c74278e59958dbecbc6f138258 04:34:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:34:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:32 INFO - mozversion application_name: Firefox 04:34:32 INFO - mozversion application_remotingname: firefox-dev 04:34:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:32 INFO - mozversion application_vendor: Mozilla 04:34:32 INFO - mozversion application_version: 49.0a2 04:34:32 INFO - mozversion platform_buildid: 20160706164923 04:34:32 INFO - mozversion platform_changeset: c1342bdc08a949c74278e59958dbecbc6f138258 04:34:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:32 INFO - mozversion platform_version: 49.0a2 04:34:32 INFO - using testdate: 1467891272 04:34:32 INFO - actual date: 1467891272 04:34:32 INFO - starting webserver on 'localhost:43837' 04:34:32 INFO - SUITE-START | Running 2 tests 04:34:32 INFO - TEST-START | dromaeo_css 04:34:32 INFO - operating with platform_type : linux_ 04:34:32 INFO - Initialising browser for dromaeo_css test... 04:34:32 INFO - TEST-INFO | started process 7021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTLWF7v/profile http://localhost:43837/getInfo.html) 04:34:37 INFO - PROCESS | 7021 | __metrics Screen width/height:1600/1200 04:34:37 INFO - PROCESS | 7021 | colorDepth:24 04:34:37 INFO - PROCESS | 7021 | Browser inner width/height: 1024/697 04:34:37 INFO - PROCESS | 7021 | __metrics 04:34:37 ERROR - PROCESS | 7021 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:34:38 INFO - TEST-INFO | 7021: exit 0 04:34:38 INFO - Browser initialized. 04:34:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:38 INFO - TEST-INFO | started process 7152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTLWF7v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:50 INFO - PROCESS | 7152 | RSS: Main: 155910144 04:34:50 INFO - PROCESS | 7152 | 04:35:40 INFO - PROCESS | 7152 | 1467891340176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:37:48 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43837/tests/dromaeo/cssquery-ext.html) 04:37:49 INFO - PROCESS | 7152 | RSS: Main: 159637504 04:37:49 INFO - PROCESS | 7152 | 04:40:51 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-ext.html (next: http://localhost:43837/tests/dromaeo/cssquery-jquery.html) 04:40:51 INFO - PROCESS | 7152 | RSS: Main: 157708288 04:40:51 INFO - PROCESS | 7152 | 04:43:53 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43837/tests/dromaeo/cssquery-mootools.html) 04:43:54 INFO - PROCESS | 7152 | RSS: Main: 157224960 04:43:54 INFO - PROCESS | 7152 | 04:46:55 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43837/tests/dromaeo/cssquery-prototype.html) 04:46:56 INFO - PROCESS | 7152 | RSS: Main: 157028352 04:46:56 INFO - PROCESS | 7152 | 04:49:59 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43837/tests/dromaeo/cssquery-yui.html) 04:49:59 INFO - PROCESS | 7152 | RSS: Main: 159260672 04:49:59 INFO - PROCESS | 7152 | 04:53:01 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-yui.html (next: http://localhost:43837/tests/dromaeo/cssquery-dojo.html) 04:53:02 INFO - PROCESS | 7152 | RSS: Main: 159272960 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | __start_tp_report 04:53:02 INFO - PROCESS | 7152 | _x_x_mozilla_page_load 04:53:02 INFO - PROCESS | 7152 | _x_x_mozilla_page_load_details 04:53:02 INFO - PROCESS | 7152 | |i|pagename|runs| 04:53:02 INFO - PROCESS | 7152 | |0;dojo.html;3362.1426536233266;3400.132966093646;3420.5382273393093;3425.9314813703727;3429.8628054877804;5614.803481878135;5649.011423000974;5660.29246344207;5702.429757024295;5704.572157088214;5675.177099320596;5696.231008813809;5717.428257174281;5719.399463056381;5733.971330143343;5119.1809310510325;5172.689638621676;5204.947950520503;5235.738213089349;5240.187770895517;5094.566961808232;5101.336826212587;5233.528982391584;5245.449227831061;5253;5139.511746384106;5168.612354073441;5172.069027575035;5179.04187725272;5217.37391513019;5217.895642087137;5230.34620672416;5234.947650523484;5243.344581927259;5264.31563896691;4929;5090.9236361454605;5131.050755610224;5178.197379406198;5220.060389129955;5508.91736623951;5576.10782274834;5583.246261754652;5591.692456914868;5646.887062258732;6076.817695469099;6130.8773824523705;6142.447179753844;6145.446909778097;6154.415330543591;5982.940170598282;6038.788642397539;6088.96955515224;6184.165137706397;6198.256209254918;5749.741261643236;5752.28096487939;5758.280214973129;5768.798092066758;5779.3642699303045;6269.5611307208055;6272.1219029335925;6275.278342990523;6277.811665650038;6279.748810047547;5778.797742079007;5823.94176058234;5855.355910849803;5870.0607902735355;5996.220491336186;5997.910031349533;6006.969965150233;6009.489193418608;6011.068284415923;6017.916774980546;5956.583039187215;5964.194833697396;5977.282726072899;5998.760049598054;6000.549958753111;5834.416558344216;5919.112133179971;5940.910886336708;5976.103584462366;6038.577299589075;4636.605888499448;4639.489656137822;4641.373414589055;4642.442906851199;4664.86005419838;4092.877213683594;4152.709310348307;4157.417961485395;4165.271077561415;4188.015816283171;5645.407232240637;5653.604247702704;5695.316562012585;5699.230603868507;5745.253117094834;6017.879642407215;6049.092636104531;6119.908201376983;6123.510119190454;6126;5685.204071430003;5793.652380857162;5795.710214489343;5800.796972106041;5805.10020946754;5167.948320516822;5195.896082078413;5227.947720522822;5238.842834714965;5252.2384254282915;6336.619802811846;6351.904721429182;6365.204349456318;6365.2998170201245;6379.521535884827;5949.762009519571;5972.104184372379;6080.726367313393;6099.268087829489;6099.3900609938655;6211.409916057967;6363.300036996019;6371;6385.10608514799;6387.265464471645;5926.259217597801;5960.195373624505;5965.940340596539;5977.910331344946;5989.311229208697;5908.822735317947;6044.365341639064;6063.333033366238;6104.796340318467;6124.228368151087;5977.462028417463;5981.700914954322;6004.309504406874;6007.90988135187;6018.969905150446;5917.467427931507;5969.04495280753;5969.552283578836;6008.279006519246;6014.308354539284;5697.088465845445;5752.309722833287;5764.538836893123;5819;5886.852828679317;5925.644461332334;5961.463468287875;5962.4633782959745;5963.403659634002;5997.490213331916;5869.765209391748;5878.412158784258;5883.470487656132;5891.558133140117;5896.115582662635 04:53:02 INFO - PROCESS | 7152 | |1;ext.html;588.3792598808255;635.5773410681895;645.2772894358317;658.3515237491071;663.0617675988476;42972.785136074315;47688.52311476893;47906.76046619762;48091.27863082057;48187.75906120469;48909.75545122278;49761.25358119622;49880.251796223;50033.24950125742;50244.49755502444;8915.955420222906;9133.269338452941;9166.954165229197;9175.587098580547;9182.586783594754;8946.731598052036;9013.909860901405;9034.593443295034;9037.457752534836;9051.366404351698;9031.954840225822;9033.23217526511;9078.455292682427;9080.137386948229;9096.909030909672;8983.236424903924;9019.052999435064;9030.232430243437;9049.049849765746;9059.320550958671;8991.865122023175;8997.685081022199;9088.409253398508;9105.089491050909;9111.772205694844;44998.550014499764;45048;45451.09097818058;45533.08933821305;45549;3602.873899413534;3787.2425514896854;3790.507234059555;3814.828332725034;3844.1542860570908;35131;35312.646873531194;35682.82158589191;35703;35941.10147246314;4689.132510485571;4734.905301893943;4739.241721324572;4740.028294199681;4749.26386410107;395594;401195;401270;402121;402829;68857.65571172112;68991.31008689849;69012.30987690159;69089.65455172693;69100;40438;41241.793791030854;41660.79169604133;43838.56161438409;44014.339784903255;19598.608027839648;19833.30583429573;19917.60164796696;19924.402267931986;19944.20223191056;15080.095194288378;15097.018693785089;15106.848931510764;15216.771748423562;15282.38870445192;22217.11131554752;22360.888195559244;22380.440488987904;22427.32718018462;22495;7336.816579585553;7366.668499917517;7439.590822504814;7458.2541745826065;7549;1035.7514196592763;1068.5405275731355;1103.668899330214;1106.3804269609045;1143.0969534068158;34521.654783452344;34735.82632086823;34830;35114;35593.466098008554;1082.9458527073614;1136.181948996721;1148.328227986637;1183.2782002978176;1221.828943947848;18247.72628410575;18274.17766200524;18541.814581854007;18582.628347433245;18826.62346753057;590173;607422;625751;638753;638757;64904;65246.34753652403;65418.345816542176;65447;65510.344896551374;1376.4356613788298;1410.8659677330638;1412.7810189420657;1418.4326269492285;1421.5095791951967;33577.66422335843;34211.65788342085;35099.29801404009;35242.47136293009;35315.646843531234;57026.714866425405;57502.7124864373;57553;57585.712071439375;57806.71096644658;413061;413797;414908;415074;415524;30973.380532389678;31069.533956991116;31699;31815.68184318127;31887.521687175176;52275.47724522858;52582;52753;53510;54252.72873635607;43273.3508997359;43671.126577467636;44462.77768611136;44801.55198447974;46460;43595.78202108969;43615;44162.779186103864;44313.9743468029;44930;44024.55975440205;44395.55604444043;44669.77665111654;44736.10527789491;45243;38457.615423845404;38553.421698675105;38729.6127038726;39239.21521569495;40145.79927100346;29200.831966721093;29440.852795735886;30053.849730751208;30073.548896767003;30221.395572088873 04:53:02 INFO - PROCESS | 7152 | |2;jquery.html;428.7256156060122;430.1354277901418;430.60169343357387;431.2711517535367;446.38844782647755;19649.901750491244;19801;20447.284345047927;20453.48866278344;20725.792742072575;19606.215751369964;19665;19797.307094251704;20557;20711.792882071175;5685.573581981357;5825.184474173598;5864.885671722381;5887.1463637772495;5903.439173278553;5719.313682358123;5726.940516004532;5811.709414529278;5827.03853864114;5901.05583106703;5803.419658034184;5854.414558544133;5856.355800861902;5860.062390017598;5874.089516124986;5706.885862282752;5830.038043722802;5850.4734573888345;5907.409259074101;5917.733701983421;5266.97366513165;5295.655782374133;5297.364316282071;5321.893562128775;5347.545458635982;18190.45428637143;19446.902765486222;23750;24550.263492095266;24730.25809225726;2276.2260831317267;2466.3094333586623;2543.872806359693;2583.0313632387856;2835.1069413134796;15210.695786084216;15277.236138193157;15630.374785008586;15744.291506882219;15938.043717376995;2022.1506967073865;2106.694529293259;2132.3389749177804;2153.2894144932134;2229.041512149775;53228.201576976375;55086.449135508534;78579.21420785776;81353.59323203345;81993.59003205005;9939;10738.463076846127;11508.367039812723;11772.117091218193;11888.88111118895;16443.5889102771;16485.34058637641;16489;16567.917160414363;16658.4169554065;8860.113988601217;9001;9021.864672029924;9118.40730352525;9256.305777066613;8717.956410217908;8877.33419993503;8897.599608017656;8954.23888969432;9066.365354425126;7034.824129396806;7171.462140339496;7239.963800181071;7240.420766338681;7281;1882.2471011595198;1900.106949733623;2047.4574237826987;2060.3509894383224;2087.3946555499037;1001.7395477175841;1083.566573370658;1140.9788239525578;1165.661958032178;1200.039968025576;20426;20670.896645516976;20953.580928381652;21174;21244.25645102414;1041.7603951091291;1055.076807793181;1067.5729708116814;1069.9090577301017;1077.3751224289892;11618;11774.175807693551;11978.58074967372;12107.757844843054;12228.694282642828;553337;554860;554931;581529;589029;83595;89283;90268.5486572563;91389;91405;1068.5885933915342;1129.0967226218993;1135.534430883334;1137.0960086731068;1142.308903113621;17971.910140449214;18170.182341794385;18364.26542938321;18496.16767245504;18555;42353.57646423496;44189.558104418546;44282;45185.0962980732;45462;61181.69409152926;61357.07964380627;61731.691341543;63891;64306.678466607365;8785.472871627722;8949.239314658327;8976.494170913313;9038.46346121174;9157;10029.448380339152;10891.509882055168;13316.267605281802;13476.730465390441;13722.931385343009;11470.311781293149;11804.940975295069;11888.048956083665;11965.341906195243;12019.21875078117;11462.312261264351;11629;11758.882411175779;12098.576549820715;12309.384530773605;11893.643190704293;12152.635420937033;12194.51221951112;12204.206726562745;12326.260424374566;8886.24466920319;9005;9068.455892646462;9096.317776166947;9129.77175570616;10470.790584188122;11486.770264594828;11796.587119450778;12173.147879648339;12489.687757806127 04:53:02 INFO - PROCESS | 7152 | |3;mootools.html;1570.9239171167746;1618.158557550074;1777.662244173607;1851.6019055902977;1851.9907400462987;8431.70489032884;8950.970638376588;9113.088691130892;9582.520873956291;9603.66387176449;9154.359194856363;9234.67678631248;9235.769105772359;9277.304202184829;9291.674791382304;2506.8495890246554;2533.278015765507;2546.694396672402;2552.1450314144786;2552.247087109298;2447.938801529967;2525.936851578716;2527.5829488134436;2536.048981631888;2538.4161642822164;2463.950720985579;2467.962980555284;2486.105002199207;2515.584928486807;2516.924492265235;2403.7716416940452;2413.263954493879;2426.963595546068;2436.2569416328015;2437.683101196842;2472.2583225032417;2476.3809047738064;2484.776370126679;2510.0336370497307;2510.949781004388;9158.86261706075;9243.26053915685;9254.6298148074;9259.490728009956;9291.72124836256;5576.832695019156;5726.455986681259;5782.97108514459;5783.161441590988;5788.623739456922;3587.1390866192187;3694;3747.138158223624;3790.5261842269715;3794.260119276742;1182.2256422043574;1253.7680529102054;1266.7276535544902;2269.265535030301;2353.164626557582;13098.607041788762;13191.40638671262;13263.602091937257;13270.535531256457;13379.331033448289;4869.123557759637;4960.727160006162;4966.304717339575;5027.547520723152;5036.765992331902;10289.639862604923;10359.430231337197;10397.948010259901;10423.218258630633;10483.423411712429;5598.916016259759;5681.602287839894;5687.061634830289;5702.600817942787;5706.201131841545;4551.362809206714;5086.059079070384;5252.947470525246;5257.027449921777;5309.628326017141;4159.480064991876;4190.790460476964;4223.704340696183;4260.446142001582;4260.510041345285;1228.2323547782637;1266.0757646917803;1268.822364868919;1269.7016201192712;1289.7098152915519;1055.9472026398803;1063.744701271689;1064.632701717906;1073.5169173871632;1076.6985244131656;6230.096635987757;6300.117983482316;6317.084022816666;6474.028895665594;6542.967285163544;481.3189337088051;487.4077995235735;493.82222399935995;495.1780045125075;497.6168350370195;4216.430781844473;4234.1108367242605;4278.379634952977;4285.785710714452;4378.56214378566;11532.538698451968;11896;12080.275183489019;12094;12095.27428354284;11883.227590206781;11922.284662920252;11958.461869215906;12020.459079341275;12024.398780060961;8119.79700507492;8308.376871734523;8376.916230837614;8523.659053637784;8524.57377131141;6418.679066046772;6625;6716.261211266659;6762.932370676427;6771.864562708817;10789.62236321725;10799.838002430128;10872.891271087188;11104.888951110386;11165.274257173258;11044.502997365298;11050.226484146033;11053;11271.830922536332;11285.774284514428;8072;8165.305948994402;8286.129956354496;8307.37694672914;8347.207015333533;9312.674056407994;9316.254699624149;9333.719988400358;9334.299927505328;9372.297077719062;8146.959265203636;8307.501549907025;8313.043999940084;8344.040435350013;8425.831483370175;8186.058603260702;8189.22202390772;8227.259546640831;8338.624761885609;8497;7102.289771022856;7349.265073492822;7353.37496312798;7435.776926692208;7493.288137626917;5610.648090558527;5643.689597072201;5683.545316374597;5761.164631128379;5839.678817664899;5338.733063346895;5346.866328341823;5375.838724838105;5390.4879036491475;5515.310586176728 04:53:02 INFO - PROCESS | 7152 | |4;prototype.html;353.8566880413432;356.8715262505498;358.69690111855505;359.3441968407655;360.1302853608534;5676.829695109143;5740.569457290704;5774.52749548865;5789.334226563947;5789.507891829199;5562;5584.078627026546;5616.297962754656;5626.437356264371;5662.546996240301;4177.820600052642;4357.586029327209;4375.14684636496;4375.14684636496;4378.605925466707;4289.420928174688;4295.1839150561445;4329.848455304049;4351.129774045188;4359.3025115981445;4368.475782906055;4373.234683930315;4377;4400.493943196525;4406.97796511017;4087.550369459372;4299.806508707115;4324.243257429968;4344.695871289011;4398.582134697199;3750.1749615084636;3756.9248615027545;3782.9054273643105;3788.1287303919976;3802.2965751335814;5439.374471935738;5467.316585426822;5487.862803429946;5497.783796479064;5513.283273174502;4994.950050499485;5018.498150184989;5056.696598204083;5059.6458247922665;5101.285819985205;5794.246747922743;5821.941780582182;5898.351181370046;5905.202797622309;5910.143029260733;4221.873343799691;4236.555161708007;4245.936310955338;4270.743755374688;4273.636740877029;5810.244668193108;6019.969900150515;6090.634561926298;6111.327753947062;6225.906611400833;4139.551157094993;4197.643200327945;4209.768462734518;4215.388768628532;4220.767857767791;4273.444452221253;4286.585426809208;4288.549702281215;4296.140771845581;4296.806643701041;4906.460289368167;4973.90052198954;4986.4514903360605;4990.326305948723;4997.0505603935135;5963.880722385528;5971.343152253248;5986.461218490357;5987.341392446828;5996.910046349309;1491.61963699256;1509.230292550807;1510.5996910818642;1511.909285442877;1516.8093046958086;937.3204426790522;943.4103685196752;955.8672972527577;961.9130382667541;966.8018056298442;5084.949150508522;5143.948560514422;5148.073346797538;5153.819616313411;5196.376434827769;5360.865978350573;5462;5504.339479262434;5544.63959842609;5565;4903.414595567116;5108.208227724708;5148.304978827885;5226.216067589816;5229.529342359206;2895.942081158365;2906.287959449948;2920.2845302900923;2939.573761804569;2958.3343747656604;5627.283678478022;5636.60543761941;5651.237082993825;5694.772209111672;5712.485876271073;5195.948040519622;5500.889982200413;5520.91718624221;5530.364008139116;5544.445555444504;5588.273524441796;5597.692126932976;5616.943830561724;5663.745131469093;5676.829695109071;5198.324217851807;5428.4842939920645;5461.098918678374;5475.479829416199;5477.835664930059;5337.412884582615;5350.571954243574;5397.460253974571;5411.2965314508865;5455.754491047833;6127.417895299939;6287.371262873676;6384.425401713868;6391.3289104643345;6418.19772528434;4327;4332.805023773874;4341.913161736685;4353;4364.781760911878;5961.940380596138;6017.247844019497;6122.408173874735;6139.3246742857355;6173.104899789595;5990.7004649768205;6028.939710603014;6039.4262545058145;6043.3050199227655;6044.546659000504;5939.940600593939;5980.282366116094;5992.550558708202;6010.789622363196;6032.366601506954;5604.6356986797355;5849.678267695318;5890.318550905684;5919.585629005928;5977.193078934462;6001.819945401645;6023.66869822164;6036.456718895321;6056.273247210187;6070.301915279622;5635.9436405635415;5913;5936.940630593812;5946.762129514771;5947 04:53:02 INFO - PROCESS | 7152 | |5;yui.html;799.8160423102686;807.6325272001236;868.6655637579532;918.2791508665697;918.9445095058923;16108.516744497669;16402.83597164028;16610.086445245506;16817.663646727073;17087.658246835057;16811.32754689811;17038.82961170388;17634.559136021606;17645.470635880913;17765.644687106284;887.4586502233632;888.2627419242014;891.8528442806929;895.9686410975618;895.9820803583924;892.9330300227476;921.2675922641482;923.8244733500613;924.0574613893824;926.073926073926;938.8591711243334;947.7583216279874;949.0225068179751;950.2208189284789;951.9904800951971;938.666773295484;942.5805516545174;944.8677185194078;946.1673727120159;947.5072962059725;687.9793606191822;694.0560837261321;694.8922916947881;695.7147569496482;698.4377576051277;16777.077260750655;16926.069066201355;16973.83026169735;17014.06422646754;17064.317427302893;14593.635159121108;14917.254137293092;15002.324895379625;15170.165640889747;15530.767038494432;12966.80549791754;13261.46954121834;13325.66685832862;13439.395227214798;13542;4103.363978583325;4105.4252404663375;4127.153933443637;4156.501219853607;4166.062635906927;64191;64344.678276608785;64900.350996489906;64981.67509162471;68820.6558967207;11844.348560829238;12045.33750643723;12054.758904821854;12165.5133794649;12171.756564868652;22705.88647056754;22957.42606434819;22978.19576314821;23008;23134.190303339303;9351.39215950961;9370.34407591462;9414.388064775767;9433.433993960385;9639.18066964316;5061.316722242524;5155.432902380735;5180.378354597472;5218.139007063868;5222.086134926372;3797.582265950743;3951.8419263229725;3952.5849785772657;3957.8021098944937;3957.881263562098;696.7178292791427;697.1494776372919;709.521073275537;717.0534893940053;721.8520203358299;839.1608391608391;842.0863363250942;844.9408541402166;845.040878602778;851.9701810436729;10356.067953884187;10803.351798892092;10834.891651083546;10926.562937482411;11041.447927603587;764.7782143178416;798.636620337745;801.8396320735876;827.2058823529359;829.4649950781712;4758.595519380822;4782.450018247946;4784.6889952153;4862.294967229803;4937.604991600663;72944;101514.98485015203;115531.11172220761;117692.41153794176;120464.3976780128;65181.34818651753;65663.34336656668;78317.60841195872;82520;99471.50264248632;86360.56819715862;86582.1341786574;86770.56614716887;87252;87516.56241718878;9604.75988100303;9668.661596844358;9778.9022109778;9795.706128816148;9834.557444914853;54037.72981135069;54159.729201353744;54268.45731542634;54655.453445465035;55811.72094139503;68060.6596967012;69191.65404172947;70111.59776804333;75413.62293188718;80307.19692803231;14673;15022.09867407959;15220.162891040656;15293.158876261467;15741.44904928322;15355.155466449452;16102.838971610134;16500.917495412446;16829.074400908066;17410.73883891768;13935.93032034874;14160.221187834355;14338.354774035402;14446.277686115862;15032.699346013238;14494.492692755703;15514.301856416263;15581.143037133066;15659.765103523685;15723.921380393482;14144.43422263098;14532.491362802251;14630.049046811922;14682.119072855663;15130.924345378202;11881.762364752483;12291.938540307241;12295.69260768488;12530.436130373973;12575.874241257836;11962.342071186169;12500.24998500093;12959.935200324315;13009.154404963647;13257.80113298282 04:53:02 INFO - PROCESS | 7152 | __end_tp_report 04:53:02 INFO - PROCESS | 7152 | __start_cc_report 04:53:02 INFO - PROCESS | 7152 | _x_x_mozilla_cycle_collect,328 04:53:02 INFO - PROCESS | 7152 | __end_cc_report 04:53:02 INFO - PROCESS | 7152 | __startTimestamp1467892382240__endTimestamp 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | ------- Summary: start ------- 04:53:02 INFO - PROCESS | 7152 | Number of tests: 6 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#0] dojo.html Cycles:165 Average:5643.99 Median:5855.36 stddev:626.20 (10.7%) stddev-sans-first:602.00 04:53:02 INFO - PROCESS | 7152 | Values: 3362.1 3400.1 3420.5 3425.9 3429.9 5614.8 5649.0 5660.3 5702.4 5704.6 5675.2 5696.2 5717.4 5719.4 5734.0 5119.2 5172.7 5204.9 5235.7 5240.2 5094.6 5101.3 5233.5 5245.4 5253.0 5139.5 5168.6 5172.1 5179.0 5217.4 5217.9 5230.3 5234.9 5243.3 5264.3 4929.0 5090.9 5131.1 5178.2 5220.1 5508.9 5576.1 5583.2 5591.7 5646.9 6076.8 6130.9 6142.4 6145.4 6154.4 5982.9 6038.8 6089.0 6184.2 6198.3 5749.7 5752.3 5758.3 5768.8 5779.4 6269.6 6272.1 6275.3 6277.8 6279.7 5778.8 5823.9 5855.4 5870.1 5996.2 5997.9 6007.0 6009.5 6011.1 6017.9 5956.6 5964.2 5977.3 5998.8 6000.5 5834.4 5919.1 5940.9 5976.1 6038.6 4636.6 4639.5 4641.4 4642.4 4664.9 4092.9 4152.7 4157.4 4165.3 4188.0 5645.4 5653.6 5695.3 5699.2 5745.3 6017.9 6049.1 6119.9 6123.5 6126.0 5685.2 5793.7 5795.7 5800.8 5805.1 5167.9 5195.9 5227.9 5238.8 5252.2 6336.6 6351.9 6365.2 6365.3 6379.5 5949.8 5972.1 6080.7 6099.3 6099.4 6211.4 6363.3 6371.0 6385.1 6387.3 5926.3 5960.2 5965.9 5977.9 5989.3 5908.8 6044.4 6063.3 6104.8 6124.2 5977.5 5981.7 6004.3 6007.9 6019.0 5917.5 5969.0 5969.6 6008.3 6014.3 5697.1 5752.3 5764.5 5819.0 5886.9 5925.6 5961.5 5962.5 5963.4 5997.5 5869.8 5878.4 5883.5 5891.6 5896.1 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#1] ext.html Cycles:180 Average:65127.25 Median:44093.67 stddev:129806.03 (294.4%) stddev-sans-first:130079.73 04:53:02 INFO - PROCESS | 7152 | Values: 588.4 635.6 645.3 658.4 663.1 42972.8 47688.5 47906.8 48091.3 48187.8 48909.8 49761.3 49880.3 50033.2 50244.5 8916.0 9133.3 9167.0 9175.6 9182.6 8946.7 9013.9 9034.6 9037.5 9051.4 9032.0 9033.2 9078.5 9080.1 9096.9 8983.2 9019.1 9030.2 9049.0 9059.3 8991.9 8997.7 9088.4 9105.1 9111.8 44998.6 45048.0 45451.1 45533.1 45549.0 3602.9 3787.2 3790.5 3814.8 3844.2 35131.0 35312.6 35682.8 35703.0 35941.1 4689.1 4734.9 4739.2 4740.0 4749.3 395594.0 401195.0 401270.0 402121.0 402829.0 68857.7 68991.3 69012.3 69089.7 69100.0 40438.0 41241.8 41660.8 43838.6 44014.3 19598.6 19833.3 19917.6 19924.4 19944.2 15080.1 15097.0 15106.8 15216.8 15282.4 22217.1 22360.9 22380.4 22427.3 22495.0 7336.8 7366.7 7439.6 7458.3 7549.0 1035.8 1068.5 1103.7 1106.4 1143.1 34521.7 34735.8 34830.0 35114.0 35593.5 1082.9 1136.2 1148.3 1183.3 1221.8 18247.7 18274.2 18541.8 18582.6 18826.6 590173.0 607422.0 625751.0 638753.0 638757.0 64904.0 65246.3 65418.3 65447.0 65510.3 1376.4 1410.9 1412.8 1418.4 1421.5 33577.7 34211.7 35099.3 35242.5 35315.6 57026.7 57502.7 57553.0 57585.7 57806.7 413061.0 413797.0 414908.0 415074.0 415524.0 30973.4 31069.5 31699.0 31815.7 31887.5 52275.5 52582.0 52753.0 53510.0 54252.7 43273.4 43671.1 44462.8 44801.6 46460.0 43595.8 43615.0 44162.8 44314.0 44930.0 44024.6 44395.6 44669.8 44736.1 45243.0 38457.6 38553.4 38729.6 39239.2 40145.8 29200.8 29440.9 30053.8 30073.5 30221.4 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#2] jquery.html Cycles:180 Average:31432.94 Median:2252.63 stddev:92890.99 (4123.7%) stddev-sans-first:93122.40 04:53:02 INFO - PROCESS | 7152 | Values: 428.7 430.1 430.6 431.3 446.4 19649.9 19801.0 20447.3 20453.5 20725.8 19606.2 19665.0 19797.3 20557.0 20711.8 5685.6 5825.2 5864.9 5887.1 5903.4 5719.3 5726.9 5811.7 5827.0 5901.1 5803.4 5854.4 5856.4 5860.1 5874.1 5706.9 5830.0 5850.5 5907.4 5917.7 5267.0 5295.7 5297.4 5321.9 5347.5 18190.5 19446.9 23750.0 24550.3 24730.3 2276.2 2466.3 2543.9 2583.0 2835.1 15210.7 15277.2 15630.4 15744.3 15938.0 2022.2 2106.7 2132.3 2153.3 2229.0 53228.2 55086.4 78579.2 81353.6 81993.6 9939.0 10738.5 11508.4 11772.1 11888.9 16443.6 16485.3 16489.0 16567.9 16658.4 8860.1 9001.0 9021.9 9118.4 9256.3 8718.0 8877.3 8897.6 8954.2 9066.4 7034.8 7171.5 7240.0 7240.4 7281.0 1882.2 1900.1 2047.5 2060.4 2087.4 1001.7 1083.6 1141.0 1165.7 1200.0 20426.0 20670.9 20953.6 21174.0 21244.3 1041.8 1055.1 1067.6 1069.9 1077.4 11618.0 11774.2 11978.6 12107.8 12228.7 553337.0 554860.0 554931.0 581529.0 589029.0 83595.0 89283.0 90268.5 91389.0 91405.0 1068.6 1129.1 1135.5 1137.1 1142.3 17971.9 18170.2 18364.3 18496.2 18555.0 42353.6 44189.6 44282.0 45185.1 45462.0 61181.7 61357.1 61731.7 63891.0 64306.7 8785.5 8949.2 8976.5 9038.5 9157.0 10029.4 10891.5 13316.3 13476.7 13722.9 11470.3 11804.9 11888.0 11965.3 12019.2 11462.3 11629.0 11758.9 12098.6 12309.4 11893.6 12152.6 12194.5 12204.2 12326.3 8886.2 9005.0 9068.5 9096.3 9129.8 10470.8 11486.8 11796.6 12173.1 12489.7 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#3] mootools.html Cycles:180 Average:6211.73 Median:2516.34 stddev:3535.99 (140.5%) stddev-sans-first:3528.72 04:53:02 INFO - PROCESS | 7152 | Values: 1570.9 1618.2 1777.7 1851.6 1852.0 8431.7 8951.0 9113.1 9582.5 9603.7 9154.4 9234.7 9235.8 9277.3 9291.7 2506.8 2533.3 2546.7 2552.1 2552.2 2447.9 2525.9 2527.6 2536.0 2538.4 2464.0 2468.0 2486.1 2515.6 2516.9 2403.8 2413.3 2427.0 2436.3 2437.7 2472.3 2476.4 2484.8 2510.0 2510.9 9158.9 9243.3 9254.6 9259.5 9291.7 5576.8 5726.5 5783.0 5783.2 5788.6 3587.1 3694.0 3747.1 3790.5 3794.3 1182.2 1253.8 1266.7 2269.3 2353.2 13098.6 13191.4 13263.6 13270.5 13379.3 4869.1 4960.7 4966.3 5027.5 5036.8 10289.6 10359.4 10397.9 10423.2 10483.4 5598.9 5681.6 5687.1 5702.6 5706.2 4551.4 5086.1 5252.9 5257.0 5309.6 4159.5 4190.8 4223.7 4260.4 4260.5 1228.2 1266.1 1268.8 1269.7 1289.7 1055.9 1063.7 1064.6 1073.5 1076.7 6230.1 6300.1 6317.1 6474.0 6543.0 481.3 487.4 493.8 495.2 497.6 4216.4 4234.1 4278.4 4285.8 4378.6 11532.5 11896.0 12080.3 12094.0 12095.3 11883.2 11922.3 11958.5 12020.5 12024.4 8119.8 8308.4 8376.9 8523.7 8524.6 6418.7 6625.0 6716.3 6762.9 6771.9 10789.6 10799.8 10872.9 11104.9 11165.3 11044.5 11050.2 11053.0 11271.8 11285.8 8072.0 8165.3 8286.1 8307.4 8347.2 9312.7 9316.3 9333.7 9334.3 9372.3 8147.0 8307.5 8313.0 8344.0 8425.8 8186.1 8189.2 8227.3 8338.6 8497.0 7102.3 7349.3 7353.4 7435.8 7493.3 5610.6 5643.7 5683.5 5761.2 5839.7 5338.7 5346.9 5375.8 5390.5 5515.3 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#4] prototype.html Cycles:180 Average:4838.51 Median:5461.55 stddev:1420.42 (26.0%) stddev-sans-first:1383.94 04:53:02 INFO - PROCESS | 7152 | Values: 353.9 356.9 358.7 359.3 360.1 5676.8 5740.6 5774.5 5789.3 5789.5 5562.0 5584.1 5616.3 5626.4 5662.5 4177.8 4357.6 4375.1 4375.1 4378.6 4289.4 4295.2 4329.8 4351.1 4359.3 4368.5 4373.2 4377.0 4400.5 4407.0 4087.6 4299.8 4324.2 4344.7 4398.6 3750.2 3756.9 3782.9 3788.1 3802.3 5439.4 5467.3 5487.9 5497.8 5513.3 4995.0 5018.5 5056.7 5059.6 5101.3 5794.2 5821.9 5898.4 5905.2 5910.1 4221.9 4236.6 4245.9 4270.7 4273.6 5810.2 6020.0 6090.6 6111.3 6225.9 4139.6 4197.6 4209.8 4215.4 4220.8 4273.4 4286.6 4288.5 4296.1 4296.8 4906.5 4973.9 4986.5 4990.3 4997.1 5963.9 5971.3 5986.5 5987.3 5996.9 1491.6 1509.2 1510.6 1511.9 1516.8 937.3 943.4 955.9 961.9 966.8 5084.9 5143.9 5148.1 5153.8 5196.4 5360.9 5462.0 5504.3 5544.6 5565.0 4903.4 5108.2 5148.3 5226.2 5229.5 2895.9 2906.3 2920.3 2939.6 2958.3 5627.3 5636.6 5651.2 5694.8 5712.5 5195.9 5500.9 5520.9 5530.4 5544.4 5588.3 5597.7 5616.9 5663.7 5676.8 5198.3 5428.5 5461.1 5475.5 5477.8 5337.4 5350.6 5397.5 5411.3 5455.8 6127.4 6287.4 6384.4 6391.3 6418.2 4327.0 4332.8 4341.9 4353.0 4364.8 5961.9 6017.2 6122.4 6139.3 6173.1 5990.7 6028.9 6039.4 6043.3 6044.5 5939.9 5980.3 5992.6 6010.8 6032.4 5604.6 5849.7 5890.3 5919.6 5977.2 6001.8 6023.7 6036.5 6056.3 6070.3 5635.9 5913.0 5936.9 5946.8 5947.0 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - PROCESS | 7152 | [#5] yui.html Cycles:180 Average:20400.68 Median:4783.57 stddev:27299.75 (570.7%) stddev-sans-first:27336.65 04:53:02 INFO - PROCESS | 7152 | Values: 799.8 807.6 868.7 918.3 918.9 16108.5 16402.8 16610.1 16817.7 17087.7 16811.3 17038.8 17634.6 17645.5 17765.6 887.5 888.3 891.9 896.0 896.0 892.9 921.3 923.8 924.1 926.1 938.9 947.8 949.0 950.2 952.0 938.7 942.6 944.9 946.2 947.5 688.0 694.1 694.9 695.7 698.4 16777.1 16926.1 16973.8 17014.1 17064.3 14593.6 14917.3 15002.3 15170.2 15530.8 12966.8 13261.5 13325.7 13439.4 13542.0 4103.4 4105.4 4127.2 4156.5 4166.1 64191.0 64344.7 64900.4 64981.7 68820.7 11844.3 12045.3 12054.8 12165.5 12171.8 22705.9 22957.4 22978.2 23008.0 23134.2 9351.4 9370.3 9414.4 9433.4 9639.2 5061.3 5155.4 5180.4 5218.1 5222.1 3797.6 3951.8 3952.6 3957.8 3957.9 696.7 697.1 709.5 717.1 721.9 839.2 842.1 844.9 845.0 852.0 10356.1 10803.4 10834.9 10926.6 11041.4 764.8 798.6 801.8 827.2 829.5 4758.6 4782.5 4784.7 4862.3 4937.6 72944.0 101515.0 115531.1 117692.4 120464.4 65181.3 65663.3 78317.6 82520.0 99471.5 86360.6 86582.1 86770.6 87252.0 87516.6 9604.8 9668.7 9778.9 9795.7 9834.6 54037.7 54159.7 54268.5 54655.5 55811.7 68060.7 69191.7 70111.6 75413.6 80307.2 14673.0 15022.1 15220.2 15293.2 15741.4 15355.2 16102.8 16500.9 16829.1 17410.7 13935.9 14160.2 14338.4 14446.3 15032.7 14494.5 15514.3 15581.1 15659.8 15723.9 14144.4 14532.5 14630.0 14682.1 15130.9 11881.8 12291.9 12295.7 12530.4 12575.9 11962.3 12500.2 12959.9 13009.2 13257.8 04:53:02 INFO - PROCESS | 7152 | -------- Summary: end -------- 04:53:02 INFO - PROCESS | 7152 | 04:53:02 INFO - TEST-INFO | 7152: exit 0 04:53:02 INFO - TEST-OK | dromaeo_css | took 1110487ms 04:53:02 INFO - TEST-START | kraken 04:53:02 INFO - operating with platform_type : linux_ 04:53:02 INFO - Initialising browser for kraken test... 04:53:02 INFO - TEST-INFO | started process 7401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfOxdT/profile http://localhost:43837/getInfo.html) 04:53:07 INFO - PROCESS | 7401 | __metrics Screen width/height:1600/1200 04:53:07 INFO - PROCESS | 7401 | colorDepth:24 04:53:07 INFO - PROCESS | 7401 | Browser inner width/height: 1024/697 04:53:07 INFO - PROCESS | 7401 | __metrics 04:53:08 ERROR - PROCESS | 7401 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:53:08 INFO - TEST-INFO | 7401: exit 0 04:53:08 INFO - Browser initialized. 04:53:08 INFO - Running cycle 1/1 for kraken test... 04:53:08 INFO - TEST-INFO | started process 7532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfOxdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:20 INFO - PROCESS | 7532 | RSS: Main: 155938816 04:53:20 INFO - PROCESS | 7532 | 04:53:23 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:24 INFO - PROCESS | 7532 | RSS: Main: 161357824 04:53:24 INFO - PROCESS | 7532 | 04:53:26 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-dft) 04:53:27 INFO - PROCESS | 7532 | RSS: Main: 160473088 04:53:27 INFO - PROCESS | 7532 | 04:53:30 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-fft) 04:53:30 INFO - PROCESS | 7532 | RSS: Main: 161681408 04:53:30 INFO - PROCESS | 7532 | 04:53:32 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-oscillator) 04:53:33 INFO - PROCESS | 7532 | RSS: Main: 161435648 04:53:33 INFO - PROCESS | 7532 | 04:53:35 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:36 INFO - PROCESS | 7532 | RSS: Main: 161292288 04:53:36 INFO - PROCESS | 7532 | 04:53:39 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:40 INFO - PROCESS | 7532 | RSS: Main: 161394688 04:53:40 INFO - PROCESS | 7532 | 04:53:43 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:44 INFO - PROCESS | 7532 | RSS: Main: 161640448 04:53:44 INFO - PROCESS | 7532 | 04:53:46 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43837/tests/kraken/driver.html?testName=json-parse-financial) 04:53:47 INFO - PROCESS | 7532 | RSS: Main: 161501184 04:53:47 INFO - PROCESS | 7532 | 04:53:49 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:49 INFO - PROCESS | 7532 | RSS: Main: 161337344 04:53:49 INFO - PROCESS | 7532 | 04:53:51 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:52 INFO - PROCESS | 7532 | RSS: Main: 161206272 04:53:52 INFO - PROCESS | 7532 | 04:53:54 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:54 INFO - PROCESS | 7532 | RSS: Main: 161685504 04:53:54 INFO - PROCESS | 7532 | 04:53:57 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:58 INFO - PROCESS | 7532 | RSS: Main: 161939456 04:53:58 INFO - PROCESS | 7532 | 04:54:00 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:01 INFO - PROCESS | 7532 | RSS: Main: 161652736 04:54:01 INFO - PROCESS | 7532 | 04:54:02 INFO - PROCESS | 7532 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43837/tests/kraken/driver.html?testName=ai-astar) 04:54:03 INFO - PROCESS | 7532 | RSS: Main: 162222080 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | __start_tp_report 04:54:03 INFO - PROCESS | 7532 | _x_x_mozilla_page_load 04:54:03 INFO - PROCESS | 7532 | _x_x_mozilla_page_load_details 04:54:03 INFO - PROCESS | 7532 | |i|pagename|runs| 04:54:03 INFO - PROCESS | 7532 | |0;ai-astar;113;105;110;111;113;111;110;111;109;110 04:54:03 INFO - PROCESS | 7532 | |1;audio-beat-detection;154;128;153;173;128;166;154;127;194;127 04:54:03 INFO - PROCESS | 7532 | |2;audio-dft;165;162;164;164;162;163;162;163;162;165 04:54:03 INFO - PROCESS | 7532 | |3;audio-fft;74;75;76;168;76;76;76;76;164;75 04:54:03 INFO - PROCESS | 7532 | |4;audio-oscillator;84;85;150;85;85;84;152;84;84;140 04:54:03 INFO - PROCESS | 7532 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;118;118;117 04:54:03 INFO - PROCESS | 7532 | |6;imaging-darkroom;147;147;149;148;147;146;147;148;149;148 04:54:03 INFO - PROCESS | 7532 | |7;imaging-desaturate;95;95;95;97;95;95;96;96;96;95 04:54:03 INFO - PROCESS | 7532 | |8;json-parse-financial;55;54;55;54;55;54;53;53;53;53 04:54:03 INFO - PROCESS | 7532 | |9;json-stringify-tinderbox;59;59;59;59;63;59;59;59;59;59 04:54:03 INFO - PROCESS | 7532 | |10;stanford-crypto-aes;87;75;76;76;83;77;77;77;110;86 04:54:03 INFO - PROCESS | 7532 | |11;stanford-crypto-ccm;128;128;117;115;127;126;118;128;136;137 04:54:03 INFO - PROCESS | 7532 | |12;stanford-crypto-pbkdf2;159;155;156;155;155;152;152;160;157;156 04:54:03 INFO - PROCESS | 7532 | |13;stanford-crypto-sha256-iterative;62;66;63;61;64;62;61;62;61;61 04:54:03 INFO - PROCESS | 7532 | __end_tp_report 04:54:03 INFO - PROCESS | 7532 | __start_cc_report 04:54:03 INFO - PROCESS | 7532 | _x_x_mozilla_cycle_collect,889 04:54:03 INFO - PROCESS | 7532 | __end_cc_report 04:54:03 INFO - PROCESS | 7532 | __startTimestamp1467892443165__endTimestamp 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | ------- Summary: start ------- 04:54:03 INFO - PROCESS | 7532 | Number of tests: 14 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.18 04:54:03 INFO - PROCESS | 7532 | Values: 113.0 105.0 110.0 111.0 113.0 111.0 110.0 111.0 109.0 110.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:23.06 (15.0%) stddev-sans-first:24.42 04:54:03 INFO - PROCESS | 7532 | Values: 154.0 128.0 153.0 173.0 128.0 166.0 154.0 127.0 194.0 127.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.23 (0.8%) stddev-sans-first:1.12 04:54:03 INFO - PROCESS | 7532 | Values: 165.0 162.0 164.0 164.0 162.0 163.0 162.0 163.0 162.0 165.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:38.18 (50.2%) stddev-sans-first:39.83 04:54:03 INFO - PROCESS | 7532 | Values: 74.0 75.0 76.0 168.0 76.0 76.0 76.0 76.0 164.0 75.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:30.54 (36.4%) stddev-sans-first:31.58 04:54:03 INFO - PROCESS | 7532 | Values: 84.0 85.0 150.0 85.0 85.0 84.0 152.0 84.0 84.0 140.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:54:03 INFO - PROCESS | 7532 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 04:54:03 INFO - PROCESS | 7532 | Values: 147.0 147.0 149.0 148.0 147.0 146.0 147.0 148.0 149.0 148.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:54:03 INFO - PROCESS | 7532 | Values: 95.0 95.0 95.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.83 04:54:03 INFO - PROCESS | 7532 | Values: 55.0 54.0 55.0 54.0 55.0 54.0 53.0 53.0 53.0 53.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.26 (2.1%) stddev-sans-first:1.33 04:54:03 INFO - PROCESS | 7532 | Values: 59.0 59.0 59.0 59.0 63.0 59.0 59.0 59.0 59.0 59.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:77.00 stddev:10.65 (13.8%) stddev-sans-first:11.16 04:54:03 INFO - PROCESS | 7532 | Values: 87.0 75.0 76.0 76.0 83.0 77.0 77.0 77.0 110.0 86.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.00 stddev:7.45 (5.8%) stddev-sans-first:7.87 04:54:03 INFO - PROCESS | 7532 | Values: 128.0 128.0 117.0 115.0 127.0 126.0 118.0 128.0 136.0 137.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:2.58 (1.7%) stddev-sans-first:2.45 04:54:03 INFO - PROCESS | 7532 | Values: 159.0 155.0 156.0 155.0 155.0 152.0 152.0 160.0 157.0 156.0 04:54:03 INFO - PROCESS | 7532 | 04:54:03 INFO - PROCESS | 7532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 04:54:03 INFO - PROCESS | 7532 | Values: 62.0 66.0 63.0 61.0 64.0 62.0 61.0 62.0 61.0 61.0 04:54:03 INFO - PROCESS | 7532 | -------- Summary: end -------- 04:54:03 INFO - PROCESS | 7532 | 04:54:04 INFO - TEST-INFO | 7532: exit 0 04:54:04 INFO - TEST-OK | kraken | took 61151ms 04:54:04 INFO - SUITE-END | took 1171s 04:54:04 INFO - Completed test suite (00:19:31) 04:54:04 INFO - javascript benchmark 04:54:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7695.303604528761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.1426536233266, 3400.132966093646, 3420.5382273393093, 3425.9314813703727, 3429.8628054877804, 5614.803481878135, 5649.011423000974, 5660.29246344207, 5702.429757024295, 5704.572157088214, 5675.177099320596, 5696.231008813809, 5717.428257174281, 5719.399463056381, 5733.971330143343, 5119.1809310510325, 5172.689638621676, 5204.947950520503, 5235.738213089349, 5240.187770895517, 5094.566961808232, 5101.336826212587, 5233.528982391584, 5245.449227831061, 5253.0, 5139.511746384106, 5168.612354073441, 5172.069027575035, 5179.04187725272, 5217.37391513019, 5217.895642087137, 5230.34620672416, 5234.947650523484, 5243.344581927259, 5264.31563896691, 4929.0, 5090.9236361454605, 5131.050755610224, 5178.197379406198, 5220.060389129955, 5508.91736623951, 5576.10782274834, 5583.246261754652, 5591.692456914868, 5646.887062258732, 6076.817695469099, 6130.8773824523705, 6142.447179753844, 6145.446909778097, 6154.415330543591, 5982.940170598282, 6038.788642397539, 6088.96955515224, 6184.165137706397, 6198.256209254918, 5749.741261643236, 5752.28096487939, 5758.280214973129, 5768.798092066758, 5779.3642699303045, 6269.5611307208055, 6272.1219029335925, 6275.278342990523, 6277.811665650038, 6279.748810047547, 5778.797742079007, 5823.94176058234, 5855.355910849803, 5870.0607902735355, 5996.220491336186, 5997.910031349533, 6006.969965150233, 6009.489193418608, 6011.068284415923, 6017.916774980546, 5956.583039187215, 5964.194833697396, 5977.282726072899, 5998.760049598054, 6000.549958753111, 5834.416558344216, 5919.112133179971, 5940.910886336708, 5976.103584462366, 6038.577299589075, 4636.605888499448, 4639.489656137822, 4641.373414589055, 4642.442906851199, 4664.86005419838, 4092.877213683594, 4152.709310348307, 4157.417961485395, 4165.271077561415, 4188.015816283171, 5645.407232240637, 5653.604247702704, 5695.316562012585, 5699.230603868507, 5745.253117094834, 6017.879642407215, 6049.092636104531, 6119.908201376983, 6123.510119190454, 6126.0, 5685.204071430003, 5793.652380857162, 5795.710214489343, 5800.796972106041, 5805.10020946754, 5167.948320516822, 5195.896082078413, 5227.947720522822, 5238.842834714965, 5252.2384254282915, 6336.619802811846, 6351.904721429182, 6365.204349456318, 6365.2998170201245, 6379.521535884827, 5949.762009519571, 5972.104184372379, 6080.726367313393, 6099.268087829489, 6099.3900609938655, 6211.409916057967, 6363.300036996019, 6371.0, 6385.10608514799, 6387.265464471645, 5926.259217597801, 5960.195373624505, 5965.940340596539, 5977.910331344946, 5989.311229208697, 5908.822735317947, 6044.365341639064, 6063.333033366238, 6104.796340318467, 6124.228368151087, 5977.462028417463, 5981.700914954322, 6004.309504406874, 6007.90988135187, 6018.969905150446, 5917.467427931507, 5969.04495280753, 5969.552283578836, 6008.279006519246, 6014.308354539284, 5697.088465845445, 5752.309722833287, 5764.538836893123, 5819.0, 5886.852828679317, 5925.644461332334, 5961.463468287875, 5962.4633782959745, 5963.403659634002, 5997.490213331916, 5869.765209391748, 5878.412158784258, 5883.470487656132, 5891.558133140117, 5896.115582662635], "value": 5603.306644172337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3792598808255, 635.5773410681895, 645.2772894358317, 658.3515237491071, 663.0617675988476, 42972.785136074315, 47688.52311476893, 47906.76046619762, 48091.27863082057, 48187.75906120469, 48909.75545122278, 49761.25358119622, 49880.251796223, 50033.24950125742, 50244.49755502444, 8915.955420222906, 9133.269338452941, 9166.954165229197, 9175.587098580547, 9182.586783594754, 8946.731598052036, 9013.909860901405, 9034.593443295034, 9037.457752534836, 9051.366404351698, 9031.954840225822, 9033.23217526511, 9078.455292682427, 9080.137386948229, 9096.909030909672, 8983.236424903924, 9019.052999435064, 9030.232430243437, 9049.049849765746, 9059.320550958671, 8991.865122023175, 8997.685081022199, 9088.409253398508, 9105.089491050909, 9111.772205694844, 44998.550014499764, 45048.0, 45451.09097818058, 45533.08933821305, 45549.0, 3602.873899413534, 3787.2425514896854, 3790.507234059555, 3814.828332725034, 3844.1542860570908, 35131.0, 35312.646873531194, 35682.82158589191, 35703.0, 35941.10147246314, 4689.132510485571, 4734.905301893943, 4739.241721324572, 4740.028294199681, 4749.26386410107, 395594.0, 401195.0, 401270.0, 402121.0, 402829.0, 68857.65571172112, 68991.31008689849, 69012.30987690159, 69089.65455172693, 69100.0, 40438.0, 41241.793791030854, 41660.79169604133, 43838.56161438409, 44014.339784903255, 19598.608027839648, 19833.30583429573, 19917.60164796696, 19924.402267931986, 19944.20223191056, 15080.095194288378, 15097.018693785089, 15106.848931510764, 15216.771748423562, 15282.38870445192, 22217.11131554752, 22360.888195559244, 22380.440488987904, 22427.32718018462, 22495.0, 7336.816579585553, 7366.668499917517, 7439.590822504814, 7458.2541745826065, 7549.0, 1035.7514196592763, 1068.5405275731355, 1103.668899330214, 1106.3804269609045, 1143.0969534068158, 34521.654783452344, 34735.82632086823, 34830.0, 35114.0, 35593.466098008554, 1082.9458527073614, 1136.181948996721, 1148.328227986637, 1183.2782002978176, 1221.828943947848, 18247.72628410575, 18274.17766200524, 18541.814581854007, 18582.628347433245, 18826.62346753057, 590173.0, 607422.0, 625751.0, 638753.0, 638757.0, 64904.0, 65246.34753652403, 65418.345816542176, 65447.0, 65510.344896551374, 1376.4356613788298, 1410.8659677330638, 1412.7810189420657, 1418.4326269492285, 1421.5095791951967, 33577.66422335843, 34211.65788342085, 35099.29801404009, 35242.47136293009, 35315.646843531234, 57026.714866425405, 57502.7124864373, 57553.0, 57585.712071439375, 57806.71096644658, 413061.0, 413797.0, 414908.0, 415074.0, 415524.0, 30973.380532389678, 31069.533956991116, 31699.0, 31815.68184318127, 31887.521687175176, 52275.47724522858, 52582.0, 52753.0, 53510.0, 54252.72873635607, 43273.3508997359, 43671.126577467636, 44462.77768611136, 44801.55198447974, 46460.0, 43595.78202108969, 43615.0, 44162.779186103864, 44313.9743468029, 44930.0, 44024.55975440205, 44395.55604444043, 44669.77665111654, 44736.10527789491, 45243.0, 38457.615423845404, 38553.421698675105, 38729.6127038726, 39239.21521569495, 40145.79927100346, 29200.831966721093, 29440.852795735886, 30053.849730751208, 30073.548896767003, 30221.395572088873], "value": 21545.143406211988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.7256156060122, 430.1354277901418, 430.60169343357387, 431.2711517535367, 446.38844782647755, 19649.901750491244, 19801.0, 20447.284345047927, 20453.48866278344, 20725.792742072575, 19606.215751369964, 19665.0, 19797.307094251704, 20557.0, 20711.792882071175, 5685.573581981357, 5825.184474173598, 5864.885671722381, 5887.1463637772495, 5903.439173278553, 5719.313682358123, 5726.940516004532, 5811.709414529278, 5827.03853864114, 5901.05583106703, 5803.419658034184, 5854.414558544133, 5856.355800861902, 5860.062390017598, 5874.089516124986, 5706.885862282752, 5830.038043722802, 5850.4734573888345, 5907.409259074101, 5917.733701983421, 5266.97366513165, 5295.655782374133, 5297.364316282071, 5321.893562128775, 5347.545458635982, 18190.45428637143, 19446.902765486222, 23750.0, 24550.263492095266, 24730.25809225726, 2276.2260831317267, 2466.3094333586623, 2543.872806359693, 2583.0313632387856, 2835.1069413134796, 15210.695786084216, 15277.236138193157, 15630.374785008586, 15744.291506882219, 15938.043717376995, 2022.1506967073865, 2106.694529293259, 2132.3389749177804, 2153.2894144932134, 2229.041512149775, 53228.201576976375, 55086.449135508534, 78579.21420785776, 81353.59323203345, 81993.59003205005, 9939.0, 10738.463076846127, 11508.367039812723, 11772.117091218193, 11888.88111118895, 16443.5889102771, 16485.34058637641, 16489.0, 16567.917160414363, 16658.4169554065, 8860.113988601217, 9001.0, 9021.864672029924, 9118.40730352525, 9256.305777066613, 8717.956410217908, 8877.33419993503, 8897.599608017656, 8954.23888969432, 9066.365354425126, 7034.824129396806, 7171.462140339496, 7239.963800181071, 7240.420766338681, 7281.0, 1882.2471011595198, 1900.106949733623, 2047.4574237826987, 2060.3509894383224, 2087.3946555499037, 1001.7395477175841, 1083.566573370658, 1140.9788239525578, 1165.661958032178, 1200.039968025576, 20426.0, 20670.896645516976, 20953.580928381652, 21174.0, 21244.25645102414, 1041.7603951091291, 1055.076807793181, 1067.5729708116814, 1069.9090577301017, 1077.3751224289892, 11618.0, 11774.175807693551, 11978.58074967372, 12107.757844843054, 12228.694282642828, 553337.0, 554860.0, 554931.0, 581529.0, 589029.0, 83595.0, 89283.0, 90268.5486572563, 91389.0, 91405.0, 1068.5885933915342, 1129.0967226218993, 1135.534430883334, 1137.0960086731068, 1142.308903113621, 17971.910140449214, 18170.182341794385, 18364.26542938321, 18496.16767245504, 18555.0, 42353.57646423496, 44189.558104418546, 44282.0, 45185.0962980732, 45462.0, 61181.69409152926, 61357.07964380627, 61731.691341543, 63891.0, 64306.678466607365, 8785.472871627722, 8949.239314658327, 8976.494170913313, 9038.46346121174, 9157.0, 10029.448380339152, 10891.509882055168, 13316.267605281802, 13476.730465390441, 13722.931385343009, 11470.311781293149, 11804.940975295069, 11888.048956083665, 11965.341906195243, 12019.21875078117, 11462.312261264351, 11629.0, 11758.882411175779, 12098.576549820715, 12309.384530773605, 11893.643190704293, 12152.635420937033, 12194.51221951112, 12204.206726562745, 12326.260424374566, 8886.24466920319, 9005.0, 9068.455892646462, 9096.317776166947, 9129.77175570616, 10470.790584188122, 11486.770264594828, 11796.587119450778, 12173.147879648339, 12489.687757806127], "value": 9815.37778047935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.9239171167746, 1618.158557550074, 1777.662244173607, 1851.6019055902977, 1851.9907400462987, 8431.70489032884, 8950.970638376588, 9113.088691130892, 9582.520873956291, 9603.66387176449, 9154.359194856363, 9234.67678631248, 9235.769105772359, 9277.304202184829, 9291.674791382304, 2506.8495890246554, 2533.278015765507, 2546.694396672402, 2552.1450314144786, 2552.247087109298, 2447.938801529967, 2525.936851578716, 2527.5829488134436, 2536.048981631888, 2538.4161642822164, 2463.950720985579, 2467.962980555284, 2486.105002199207, 2515.584928486807, 2516.924492265235, 2403.7716416940452, 2413.263954493879, 2426.963595546068, 2436.2569416328015, 2437.683101196842, 2472.2583225032417, 2476.3809047738064, 2484.776370126679, 2510.0336370497307, 2510.949781004388, 9158.86261706075, 9243.26053915685, 9254.6298148074, 9259.490728009956, 9291.72124836256, 5576.832695019156, 5726.455986681259, 5782.97108514459, 5783.161441590988, 5788.623739456922, 3587.1390866192187, 3694.0, 3747.138158223624, 3790.5261842269715, 3794.260119276742, 1182.2256422043574, 1253.7680529102054, 1266.7276535544902, 2269.265535030301, 2353.164626557582, 13098.607041788762, 13191.40638671262, 13263.602091937257, 13270.535531256457, 13379.331033448289, 4869.123557759637, 4960.727160006162, 4966.304717339575, 5027.547520723152, 5036.765992331902, 10289.639862604923, 10359.430231337197, 10397.948010259901, 10423.218258630633, 10483.423411712429, 5598.916016259759, 5681.602287839894, 5687.061634830289, 5702.600817942787, 5706.201131841545, 4551.362809206714, 5086.059079070384, 5252.947470525246, 5257.027449921777, 5309.628326017141, 4159.480064991876, 4190.790460476964, 4223.704340696183, 4260.446142001582, 4260.510041345285, 1228.2323547782637, 1266.0757646917803, 1268.822364868919, 1269.7016201192712, 1289.7098152915519, 1055.9472026398803, 1063.744701271689, 1064.632701717906, 1073.5169173871632, 1076.6985244131656, 6230.096635987757, 6300.117983482316, 6317.084022816666, 6474.028895665594, 6542.967285163544, 481.3189337088051, 487.4077995235735, 493.82222399935995, 495.1780045125075, 497.6168350370195, 4216.430781844473, 4234.1108367242605, 4278.379634952977, 4285.785710714452, 4378.56214378566, 11532.538698451968, 11896.0, 12080.275183489019, 12094.0, 12095.27428354284, 11883.227590206781, 11922.284662920252, 11958.461869215906, 12020.459079341275, 12024.398780060961, 8119.79700507492, 8308.376871734523, 8376.916230837614, 8523.659053637784, 8524.57377131141, 6418.679066046772, 6625.0, 6716.261211266659, 6762.932370676427, 6771.864562708817, 10789.62236321725, 10799.838002430128, 10872.891271087188, 11104.888951110386, 11165.274257173258, 11044.502997365298, 11050.226484146033, 11053.0, 11271.830922536332, 11285.774284514428, 8072.0, 8165.305948994402, 8286.129956354496, 8307.37694672914, 8347.207015333533, 9312.674056407994, 9316.254699624149, 9333.719988400358, 9334.299927505328, 9372.297077719062, 8146.959265203636, 8307.501549907025, 8313.043999940084, 8344.040435350013, 8425.831483370175, 8186.058603260702, 8189.22202390772, 8227.259546640831, 8338.624761885609, 8497.0, 7102.289771022856, 7349.265073492822, 7353.37496312798, 7435.776926692208, 7493.288137626917, 5610.648090558527, 5643.689597072201, 5683.545316374597, 5761.164631128379, 5839.678817664899, 5338.733063346895, 5346.866328341823, 5375.838724838105, 5390.4879036491475, 5515.310586176728], "value": 4919.305504187607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8566880413432, 356.8715262505498, 358.69690111855505, 359.3441968407655, 360.1302853608534, 5676.829695109143, 5740.569457290704, 5774.52749548865, 5789.334226563947, 5789.507891829199, 5562.0, 5584.078627026546, 5616.297962754656, 5626.437356264371, 5662.546996240301, 4177.820600052642, 4357.586029327209, 4375.14684636496, 4375.14684636496, 4378.605925466707, 4289.420928174688, 4295.1839150561445, 4329.848455304049, 4351.129774045188, 4359.3025115981445, 4368.475782906055, 4373.234683930315, 4377.0, 4400.493943196525, 4406.97796511017, 4087.550369459372, 4299.806508707115, 4324.243257429968, 4344.695871289011, 4398.582134697199, 3750.1749615084636, 3756.9248615027545, 3782.9054273643105, 3788.1287303919976, 3802.2965751335814, 5439.374471935738, 5467.316585426822, 5487.862803429946, 5497.783796479064, 5513.283273174502, 4994.950050499485, 5018.498150184989, 5056.696598204083, 5059.6458247922665, 5101.285819985205, 5794.246747922743, 5821.941780582182, 5898.351181370046, 5905.202797622309, 5910.143029260733, 4221.873343799691, 4236.555161708007, 4245.936310955338, 4270.743755374688, 4273.636740877029, 5810.244668193108, 6019.969900150515, 6090.634561926298, 6111.327753947062, 6225.906611400833, 4139.551157094993, 4197.643200327945, 4209.768462734518, 4215.388768628532, 4220.767857767791, 4273.444452221253, 4286.585426809208, 4288.549702281215, 4296.140771845581, 4296.806643701041, 4906.460289368167, 4973.90052198954, 4986.4514903360605, 4990.326305948723, 4997.0505603935135, 5963.880722385528, 5971.343152253248, 5986.461218490357, 5987.341392446828, 5996.910046349309, 1491.61963699256, 1509.230292550807, 1510.5996910818642, 1511.909285442877, 1516.8093046958086, 937.3204426790522, 943.4103685196752, 955.8672972527577, 961.9130382667541, 966.8018056298442, 5084.949150508522, 5143.948560514422, 5148.073346797538, 5153.819616313411, 5196.376434827769, 5360.865978350573, 5462.0, 5504.339479262434, 5544.63959842609, 5565.0, 4903.414595567116, 5108.208227724708, 5148.304978827885, 5226.216067589816, 5229.529342359206, 2895.942081158365, 2906.287959449948, 2920.2845302900923, 2939.573761804569, 2958.3343747656604, 5627.283678478022, 5636.60543761941, 5651.237082993825, 5694.772209111672, 5712.485876271073, 5195.948040519622, 5500.889982200413, 5520.91718624221, 5530.364008139116, 5544.445555444504, 5588.273524441796, 5597.692126932976, 5616.943830561724, 5663.745131469093, 5676.829695109071, 5198.324217851807, 5428.4842939920645, 5461.098918678374, 5475.479829416199, 5477.835664930059, 5337.412884582615, 5350.571954243574, 5397.460253974571, 5411.2965314508865, 5455.754491047833, 6127.417895299939, 6287.371262873676, 6384.425401713868, 6391.3289104643345, 6418.19772528434, 4327.0, 4332.805023773874, 4341.913161736685, 4353.0, 4364.781760911878, 5961.940380596138, 6017.247844019497, 6122.408173874735, 6139.3246742857355, 6173.104899789595, 5990.7004649768205, 6028.939710603014, 6039.4262545058145, 6043.3050199227655, 6044.546659000504, 5939.940600593939, 5980.282366116094, 5992.550558708202, 6010.789622363196, 6032.366601506954, 5604.6356986797355, 5849.678267695318, 5890.318550905684, 5919.585629005928, 5977.193078934462, 6001.819945401645, 6023.66869822164, 6036.456718895321, 6056.273247210187, 6070.301915279622, 5635.9436405635415, 5913.0, 5936.940630593812, 5946.762129514771, 5947.0], "value": 4388.599668665666, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.8160423102686, 807.6325272001236, 868.6655637579532, 918.2791508665697, 918.9445095058923, 16108.516744497669, 16402.83597164028, 16610.086445245506, 16817.663646727073, 17087.658246835057, 16811.32754689811, 17038.82961170388, 17634.559136021606, 17645.470635880913, 17765.644687106284, 887.4586502233632, 888.2627419242014, 891.8528442806929, 895.9686410975618, 895.9820803583924, 892.9330300227476, 921.2675922641482, 923.8244733500613, 924.0574613893824, 926.073926073926, 938.8591711243334, 947.7583216279874, 949.0225068179751, 950.2208189284789, 951.9904800951971, 938.666773295484, 942.5805516545174, 944.8677185194078, 946.1673727120159, 947.5072962059725, 687.9793606191822, 694.0560837261321, 694.8922916947881, 695.7147569496482, 698.4377576051277, 16777.077260750655, 16926.069066201355, 16973.83026169735, 17014.06422646754, 17064.317427302893, 14593.635159121108, 14917.254137293092, 15002.324895379625, 15170.165640889747, 15530.767038494432, 12966.80549791754, 13261.46954121834, 13325.66685832862, 13439.395227214798, 13542.0, 4103.363978583325, 4105.4252404663375, 4127.153933443637, 4156.501219853607, 4166.062635906927, 64191.0, 64344.678276608785, 64900.350996489906, 64981.67509162471, 68820.6558967207, 11844.348560829238, 12045.33750643723, 12054.758904821854, 12165.5133794649, 12171.756564868652, 22705.88647056754, 22957.42606434819, 22978.19576314821, 23008.0, 23134.190303339303, 9351.39215950961, 9370.34407591462, 9414.388064775767, 9433.433993960385, 9639.18066964316, 5061.316722242524, 5155.432902380735, 5180.378354597472, 5218.139007063868, 5222.086134926372, 3797.582265950743, 3951.8419263229725, 3952.5849785772657, 3957.8021098944937, 3957.881263562098, 696.7178292791427, 697.1494776372919, 709.521073275537, 717.0534893940053, 721.8520203358299, 839.1608391608391, 842.0863363250942, 844.9408541402166, 845.040878602778, 851.9701810436729, 10356.067953884187, 10803.351798892092, 10834.891651083546, 10926.562937482411, 11041.447927603587, 764.7782143178416, 798.636620337745, 801.8396320735876, 827.2058823529359, 829.4649950781712, 4758.595519380822, 4782.450018247946, 4784.6889952153, 4862.294967229803, 4937.604991600663, 72944.0, 101514.98485015203, 115531.11172220761, 117692.41153794176, 120464.3976780128, 65181.34818651753, 65663.34336656668, 78317.60841195872, 82520.0, 99471.50264248632, 86360.56819715862, 86582.1341786574, 86770.56614716887, 87252.0, 87516.56241718878, 9604.75988100303, 9668.661596844358, 9778.9022109778, 9795.706128816148, 9834.557444914853, 54037.72981135069, 54159.729201353744, 54268.45731542634, 54655.453445465035, 55811.72094139503, 68060.6596967012, 69191.65404172947, 70111.59776804333, 75413.62293188718, 80307.19692803231, 14673.0, 15022.09867407959, 15220.162891040656, 15293.158876261467, 15741.44904928322, 15355.155466449452, 16102.838971610134, 16500.917495412446, 16829.074400908066, 17410.73883891768, 13935.93032034874, 14160.221187834355, 14338.354774035402, 14446.277686115862, 15032.699346013238, 14494.492692755703, 15514.301856416263, 15581.143037133066, 15659.765103523685, 15723.921380393482, 14144.43422263098, 14532.491362802251, 14630.049046811922, 14682.119072855663, 15130.924345378202, 11881.762364752483, 12291.938540307241, 12295.69260768488, 12530.436130373973, 12575.874241257836, 11962.342071186169, 12500.24998500093, 12959.935200324315, 13009.154404963647, 13257.80113298282], "value": 8116.708746803988, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 111.0, 113.0, 111.0, 110.0, 111.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 153.0, 173.0, 128.0, 166.0, 154.0, 127.0, 194.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 164.0, 162.0, 163.0, 162.0, 163.0, 162.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 168.0, 76.0, 76.0, 76.0, 76.0, 164.0, 75.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 150.0, 85.0, 85.0, 84.0, 152.0, 84.0, 84.0, 140.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 147.0, 146.0, 147.0, 148.0, 149.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 63.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 76.0, 76.0, 83.0, 77.0, 77.0, 77.0, 110.0, 86.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 117.0, 115.0, 127.0, 126.0, 118.0, 128.0, 136.0, 137.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 156.0, 155.0, 155.0, 152.0, 152.0, 160.0, 157.0, 156.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 63.0, 61.0, 64.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 62.3, "unit": "score"}]}]} 04:54:04 INFO - Return code: 0 04:54:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:04 ERROR - # TBPL SUCCESS # 04:54:04 INFO - Running post-action listener: _resource_record_post_action 04:54:04 INFO - ##### 04:54:04 INFO - ##### Finished run-tests step (success) 04:54:04 INFO - ##### 04:54:04 INFO - Running post-run listener: _resource_record_post_run 04:54:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 274432; Write bytes: 513568768; Read time: 40; Write time: 451300 04:54:04 INFO - TinderboxPrint: CPU usage
13.4% 04:54:04 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 40 04:54:04 INFO - TinderboxPrint: I/O write bytes / time
513,568,768 / 451,300 04:54:04 INFO - TinderboxPrint: CPU idle
8,211.5 (86.6%) 04:54:04 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 04:54:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:54:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 262217728; Read time: 0; Write time: 307192 04:54:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 274432; Write bytes: 251351040; Read time: 40; Write time: 144108 04:54:05 INFO - Running post-run listener: _upload_blobber_files 04:54:05 INFO - Blob upload gear active. 04:54:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:05 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 04:54:05 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:54:05 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:54:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:10 INFO - (blobuploader) - INFO - Done attempting. 04:54:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:10 INFO - (blobuploader) - INFO - Done attempting. 04:54:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:11 INFO - (blobuploader) - INFO - Done attempting. 04:54:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:11 INFO - Return code: 0 04:54:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d4fff675d0725c96e8cae08c014d8cf54838ee677e12f0e6ebcec233b6cdfca7a088480504eef463cb6770243a6663e99c78d09c5bbf5b23a62f2ff4aaa3a6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de5e60516a66fe0d222275d7db90d3ef6c2cbfd241b2e6c4be533cd8d0fb7136d0c3244eb15a074afa254d82a45c5c8466548d629ca8d6f60bcdf57ebfafbdea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e18548b79cbb20a5217ee6ba1523e06f780c19ee1ce7f7c3a3ab2852b56f7fcdb32d9c5e49c7f526a11c69b4055bcc9fbe4178321259d465d3325f16913df6e"} 04:54:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:11 INFO - Contents: 04:54:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d4fff675d0725c96e8cae08c014d8cf54838ee677e12f0e6ebcec233b6cdfca7a088480504eef463cb6770243a6663e99c78d09c5bbf5b23a62f2ff4aaa3a6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de5e60516a66fe0d222275d7db90d3ef6c2cbfd241b2e6c4be533cd8d0fb7136d0c3244eb15a074afa254d82a45c5c8466548d629ca8d6f60bcdf57ebfafbdea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e18548b79cbb20a5217ee6ba1523e06f780c19ee1ce7f7c3a3ab2852b56f7fcdb32d9c5e49c7f526a11c69b4055bcc9fbe4178321259d465d3325f16913df6e"} 04:54:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:11 INFO - Copying logs to upload dir... 04:54:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.590097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-07 04:54:11.289578) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:54:11.295351) ========= 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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d4fff675d0725c96e8cae08c014d8cf54838ee677e12f0e6ebcec233b6cdfca7a088480504eef463cb6770243a6663e99c78d09c5bbf5b23a62f2ff4aaa3a6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de5e60516a66fe0d222275d7db90d3ef6c2cbfd241b2e6c4be533cd8d0fb7136d0c3244eb15a074afa254d82a45c5c8466548d629ca8d6f60bcdf57ebfafbdea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e18548b79cbb20a5217ee6ba1523e06f780c19ee1ce7f7c3a3ab2852b56f7fcdb32d9c5e49c7f526a11c69b4055bcc9fbe4178321259d465d3325f16913df6e"} build_url:https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d4fff675d0725c96e8cae08c014d8cf54838ee677e12f0e6ebcec233b6cdfca7a088480504eef463cb6770243a6663e99c78d09c5bbf5b23a62f2ff4aaa3a6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de5e60516a66fe0d222275d7db90d3ef6c2cbfd241b2e6c4be533cd8d0fb7136d0c3244eb15a074afa254d82a45c5c8466548d629ca8d6f60bcdf57ebfafbdea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e18548b79cbb20a5217ee6ba1523e06f780c19ee1ce7f7c3a3ab2852b56f7fcdb32d9c5e49c7f526a11c69b4055bcc9fbe4178321259d465d3325f16913df6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:54:11.324982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:54:11.328729) ========= 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=cbe409c6de289db6ac707de3000001d4-1467891217.162080-562843271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:54:11.406066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:54:11.409414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:54:11.409703) ========= ========= Total master_lag: 0.19 =========