builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1464974134.81 results: success (0) buildid: 20160603073206 builduid: 56c604bfd3684fd4a4975b569f834cb3 revision: 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.808590) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.809060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.809518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.830042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.830360) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 10:15:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.7M=0s 2016-06-03 10:15:35 (48.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.920994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.921397) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.971316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:34.971702) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 --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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 10:15:35,223 truncating revision to first 12 chars 2016-06-03 10:15:35,224 Setting DEBUG logging. 2016-06-03 10:15:35,224 attempt 1/10 2016-06-03 10:15:35,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7f5e5e52d06f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 10:15:35,527 unpacking tar archive at: mozilla-inbound-7f5e5e52d06f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:35.610070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:35.610377) ========= script_repo_revision: 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:35.610818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:35.611098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 10:15:35.622652) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-03 10:15:35.622952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:35 INFO - MultiFileLogger online at 20160603 10:15:35 in /builds/slave/test 10:15:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:15:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:35 INFO - {'append_to_log': False, 10:15:35 INFO - 'base_work_dir': '/builds/slave/test', 10:15:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:15:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:35 INFO - 'branch': 'Mozilla-Inbound', 10:15:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:35 INFO - 'config_files': ('talos/linux_config.py',), 10:15:35 INFO - 'default_actions': ('clobber', 10:15:35 INFO - 'read-buildbot-config', 10:15:35 INFO - 'download-and-extract', 10:15:35 INFO - 'populate-webroot', 10:15:35 INFO - 'create-virtualenv', 10:15:35 INFO - 'install', 10:15:35 INFO - 'run-tests'), 10:15:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:35 INFO - 'download_minidump_stackwalk': True, 10:15:35 INFO - 'download_symbols': 'ondemand', 10:15:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:35 INFO - 'installer_path': 'installer.exe', 10:15:35 INFO - 'log_level': 'info', 10:15:35 INFO - 'log_name': 'talos', 10:15:35 INFO - 'log_to_console': True, 10:15:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:35 INFO - 'opt_config_files': (), 10:15:35 INFO - 'pip_index': False, 10:15:35 INFO - 'sps_profile': False, 10:15:35 INFO - 'sps_profile_interval': 0, 10:15:35 INFO - 'suite': 'dromaeojs', 10:15:35 INFO - 'system_bits': '32', 10:15:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:35 INFO - 'title': 'talos-linux64-ix-034', 10:15:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:35 INFO - 'use_talos_json': True, 10:15:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:35 INFO - 'work_dir': 'build'} 10:15:35 INFO - ##### 10:15:35 INFO - ##### Running clobber step. 10:15:35 INFO - ##### 10:15:35 INFO - Running pre-action listener: _resource_record_pre_action 10:15:35 INFO - Running main action method: clobber 10:15:35 INFO - rmtree: /builds/slave/test/build 10:15:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:36 INFO - Running post-action listener: _resource_record_post_action 10:15:36 INFO - ##### 10:15:36 INFO - ##### Finished clobber step (success) 10:15:36 INFO - ##### 10:15:36 INFO - ##### 10:15:36 INFO - ##### Running read-buildbot-config step. 10:15:36 INFO - ##### 10:15:36 INFO - Running pre-action listener: _resource_record_pre_action 10:15:36 INFO - Running main action method: read_buildbot_config 10:15:36 INFO - Using buildbot properties: 10:15:36 INFO - { 10:15:36 INFO - "project": "", 10:15:36 INFO - "product": "firefox", 10:15:36 INFO - "script_repo_revision": "production", 10:15:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:15:36 INFO - "repository": "", 10:15:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:15:36 INFO - "buildid": "20160603073206", 10:15:36 INFO - "pgo_build": "True", 10:15:36 INFO - "basedir": "/builds/slave/test", 10:15:36 INFO - "buildnumber": 1116, 10:15:36 INFO - "slavename": "talos-linux64-ix-034", 10:15:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:15:36 INFO - "platform": "ubuntu64_hw", 10:15:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:15:36 INFO - "branch": "mozilla-inbound", 10:15:36 INFO - "repo_path": "integration/mozilla-inbound", 10:15:36 INFO - "revision": "7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9", 10:15:36 INFO - "stage_platform": "linux64-pgo", 10:15:36 INFO - "builduid": "56c604bfd3684fd4a4975b569f834cb3", 10:15:36 INFO - "slavebuilddir": "test" 10:15:36 INFO - } 10:15:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:15:36 INFO - Running post-action listener: _resource_record_post_action 10:15:36 INFO - ##### 10:15:36 INFO - ##### Finished read-buildbot-config step (success) 10:15:36 INFO - ##### 10:15:36 INFO - ##### 10:15:36 INFO - ##### Running download-and-extract step. 10:15:36 INFO - ##### 10:15:36 INFO - Running pre-action listener: _resource_record_pre_action 10:15:36 INFO - Running main action method: download_and_extract 10:15:36 INFO - mkdir: /builds/slave/test/build/tests 10:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:36 INFO - https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:15:37 INFO - Downloaded 1361 bytes. 10:15:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:15:37 INFO - Using the following test package requirements: 10:15:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'jsshell-linux-x86_64.zip'], 10:15:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:37 INFO - https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:40 INFO - Downloaded 24441839 bytes. 10:15:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:15:41 INFO - Return code: 0 10:15:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:41 INFO - https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:49 INFO - Downloaded 24441839 bytes. 10:15:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:15:50 INFO - Return code: 0 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:50 INFO - https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:15:51 INFO - Downloaded 10833369 bytes. 10:15:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:15:52 INFO - Return code: 0 10:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:52 INFO - https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:15:53 INFO - Downloaded 59135786 bytes. 10:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:53 INFO - mkdir: /builds/slave/test/properties 10:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:53 INFO - Contents: 10:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - Running post-action listener: set_extra_try_arguments 10:15:54 INFO - ##### 10:15:54 INFO - ##### Finished download-and-extract step (success) 10:15:54 INFO - ##### 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running populate-webroot step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: populate_webroot 10:15:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:54 INFO - '--tppagecycles', 10:15:54 INFO - '7'], 10:15:54 INFO - 'tests': ['tsvgm']}}, 10:15:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['damp', 'tps']}, 10:15:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['damp', 'tps']}, 10:15:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['dromaeo_dom']}, 10:15:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tsvgx', 10:15:54 INFO - 'tsvgr_opacity', 10:15:54 INFO - 'tart', 10:15:54 INFO - 'tscrollx', 10:15:54 INFO - 'cart']}, 10:15:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:54 INFO - 'tsvgr_opacity', 10:15:54 INFO - 'tart', 10:15:54 INFO - 'tscrollx', 10:15:54 INFO - 'cart']}, 10:15:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tp5o']}, 10:15:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['tp5o']}, 10:15:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s', 10:15:54 INFO - '--xperf_path', 10:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:54 INFO - 'tests': ['tp5n']}, 10:15:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--xperf_path', 10:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:54 INFO - 'tests': ['tp5n']}}, 10:15:54 INFO - 'talos.zip': {'path': '', 10:15:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - ##### 10:15:54 INFO - ##### Finished populate-webroot step (success) 10:15:54 INFO - ##### 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running create-virtualenv step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: create_virtualenv 10:15:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:54 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 10:15:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:54 INFO - Using real prefix '/usr' 10:15:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:56 INFO - Installing pip.................done. 10:15:56 INFO - Return code: 0 10:15:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:56 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:15:56 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 10:15:56 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 10:15:56 INFO - Using env: {'DISPLAY': ':0', 10:15:56 INFO - 'HOME': '/home/cltbld', 10:15:56 INFO - 'LANG': 'en_US.UTF-8', 10:15:56 INFO - 'LANGUAGE': 'en_US:en', 10:15:56 INFO - 'LOGNAME': 'cltbld', 10:15:56 INFO - 'MAIL': '/var/mail/cltbld', 10:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:56 INFO - 'MOZ_NO_REMOTE': '1', 10:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:56 INFO - 'NO_EM_RESTART': '1', 10:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:56 INFO - 'PWD': '/builds/slave/test', 10:15:56 INFO - 'SHELL': '/bin/bash', 10:15:56 INFO - 'SHLVL': '1', 10:15:56 INFO - 'TERM': 'linux', 10:15:56 INFO - 'TMOUT': '86400', 10:15:56 INFO - 'USER': 'cltbld', 10:15:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:56 INFO - '_': '/tools/buildbot/bin/python'} 10:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:57 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 10:15:57 INFO - Cleaning up... 10:15:57 INFO - Return code: 0 10:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:57 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:15:57 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 10:15:57 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 10:15:57 INFO - Using env: {'DISPLAY': ':0', 10:15:57 INFO - 'HOME': '/home/cltbld', 10:15:57 INFO - 'LANG': 'en_US.UTF-8', 10:15:57 INFO - 'LANGUAGE': 'en_US:en', 10:15:57 INFO - 'LOGNAME': 'cltbld', 10:15:57 INFO - 'MAIL': '/var/mail/cltbld', 10:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:57 INFO - 'MOZ_NO_REMOTE': '1', 10:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:57 INFO - 'NO_EM_RESTART': '1', 10:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:57 INFO - 'PWD': '/builds/slave/test', 10:15:57 INFO - 'SHELL': '/bin/bash', 10:15:57 INFO - 'SHLVL': '1', 10:15:57 INFO - 'TERM': 'linux', 10:15:57 INFO - 'TMOUT': '86400', 10:15:57 INFO - 'USER': 'cltbld', 10:15:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:57 INFO - '_': '/tools/buildbot/bin/python'} 10:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:57 INFO - Downloading/unpacking psutil>=3.1.1 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:59 INFO - Installing collected packages: psutil 10:15:59 INFO - Running setup.py install for psutil 10:15:59 INFO - building 'psutil._psutil_linux' extension 10:15:59 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 10:15:59 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 10:15:59 INFO - building 'psutil._psutil_posix' extension 10:15:59 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 10:15:59 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 10:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:59 INFO - Successfully installed psutil 10:15:59 INFO - Cleaning up... 10:15:59 INFO - Return code: 0 10:15:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:59 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')]} 10:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:59 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')]} 10:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:59 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:15:59 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 10:15:59 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 10:15:59 INFO - Using env: {'DISPLAY': ':0', 10:15:59 INFO - 'HOME': '/home/cltbld', 10:15:59 INFO - 'LANG': 'en_US.UTF-8', 10:15:59 INFO - 'LANGUAGE': 'en_US:en', 10:15:59 INFO - 'LOGNAME': 'cltbld', 10:15:59 INFO - 'MAIL': '/var/mail/cltbld', 10:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:59 INFO - 'MOZ_NO_REMOTE': '1', 10:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:59 INFO - 'NO_EM_RESTART': '1', 10:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:59 INFO - 'PWD': '/builds/slave/test', 10:15:59 INFO - 'SHELL': '/bin/bash', 10:15:59 INFO - 'SHLVL': '1', 10:15:59 INFO - 'TERM': 'linux', 10:15:59 INFO - 'TMOUT': '86400', 10:15:59 INFO - 'USER': 'cltbld', 10:15:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:59 INFO - '_': '/tools/buildbot/bin/python'} 10:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:16:02 INFO - Installing collected packages: mozsystemmonitor 10:16:02 INFO - Running setup.py install for mozsystemmonitor 10:16:02 INFO - Successfully installed mozsystemmonitor 10:16:02 INFO - Cleaning up... 10:16:02 INFO - Return code: 0 10:16:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:02 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 10:16:02 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 10:16:02 INFO - Using env: {'DISPLAY': ':0', 10:16:02 INFO - 'HOME': '/home/cltbld', 10:16:02 INFO - 'LANG': 'en_US.UTF-8', 10:16:02 INFO - 'LANGUAGE': 'en_US:en', 10:16:02 INFO - 'LOGNAME': 'cltbld', 10:16:02 INFO - 'MAIL': '/var/mail/cltbld', 10:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:02 INFO - 'MOZ_NO_REMOTE': '1', 10:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:02 INFO - 'NO_EM_RESTART': '1', 10:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:02 INFO - 'PWD': '/builds/slave/test', 10:16:02 INFO - 'SHELL': '/bin/bash', 10:16:02 INFO - 'SHLVL': '1', 10:16:02 INFO - 'TERM': 'linux', 10:16:02 INFO - 'TMOUT': '86400', 10:16:02 INFO - 'USER': 'cltbld', 10:16:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:02 INFO - '_': '/tools/buildbot/bin/python'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:04 INFO - warning: no files found matching '*.txt' 10:16:04 INFO - no previously-included directories found matching 'build' 10:16:04 INFO - no previously-included directories found matching 'dist' 10:16:04 INFO - no previously-included directories found matching '.git*' 10:16:04 INFO - Installing collected packages: jsonschema, functools32 10:16:04 INFO - Running setup.py install for functools32 10:16:04 INFO - warning: no files found matching '*.txt' 10:16:04 INFO - no previously-included directories found matching 'build' 10:16:04 INFO - no previously-included directories found matching 'dist' 10:16:04 INFO - no previously-included directories found matching '.git*' 10:16:04 INFO - Successfully installed jsonschema functools32 10:16:04 INFO - Cleaning up... 10:16:04 INFO - Return code: 0 10:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:04 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:04 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 10:16:04 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 10:16:04 INFO - Using env: {'DISPLAY': ':0', 10:16:04 INFO - 'HOME': '/home/cltbld', 10:16:04 INFO - 'LANG': 'en_US.UTF-8', 10:16:04 INFO - 'LANGUAGE': 'en_US:en', 10:16:04 INFO - 'LOGNAME': 'cltbld', 10:16:04 INFO - 'MAIL': '/var/mail/cltbld', 10:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:04 INFO - 'MOZ_NO_REMOTE': '1', 10:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:04 INFO - 'NO_EM_RESTART': '1', 10:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:04 INFO - 'PWD': '/builds/slave/test', 10:16:04 INFO - 'SHELL': '/bin/bash', 10:16:04 INFO - 'SHLVL': '1', 10:16:04 INFO - 'TERM': 'linux', 10:16:04 INFO - 'TMOUT': '86400', 10:16:04 INFO - 'USER': 'cltbld', 10:16:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:04 INFO - '_': '/tools/buildbot/bin/python'} 10:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 INFO - Downloading docopt-0.6.1.tar.gz 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:07 INFO - Running setup.py install for blobuploader 10:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:07 INFO - Running setup.py install for requests 10:16:08 INFO - Running setup.py install for docopt 10:16:08 INFO - Successfully installed blobuploader requests docopt 10:16:08 INFO - Cleaning up... 10:16:08 INFO - Return code: 0 10:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:08 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')]} 10:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:08 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')]} 10:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:08 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:08 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 10:16:08 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 10:16:08 INFO - Using env: {'DISPLAY': ':0', 10:16:08 INFO - 'HOME': '/home/cltbld', 10:16:08 INFO - 'LANG': 'en_US.UTF-8', 10:16:08 INFO - 'LANGUAGE': 'en_US:en', 10:16:08 INFO - 'LOGNAME': 'cltbld', 10:16:08 INFO - 'MAIL': '/var/mail/cltbld', 10:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:08 INFO - 'MOZ_NO_REMOTE': '1', 10:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:08 INFO - 'NO_EM_RESTART': '1', 10:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:08 INFO - 'PWD': '/builds/slave/test', 10:16:08 INFO - 'SHELL': '/bin/bash', 10:16:08 INFO - 'SHLVL': '1', 10:16:08 INFO - 'TERM': 'linux', 10:16:08 INFO - 'TMOUT': '86400', 10:16:08 INFO - 'USER': 'cltbld', 10:16:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:08 INFO - '_': '/tools/buildbot/bin/python'} 10:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Running setup.py (path:/tmp/pip-Sifiap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Running setup.py (path:/tmp/pip-qq43qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Running setup.py (path:/tmp/pip-JOvBxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Running setup.py (path:/tmp/pip-0wqktt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Running setup.py (path:/tmp/pip-ynzzNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Running setup.py (path:/tmp/pip-11yuAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Running setup.py (path:/tmp/pip-Rl97q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Running setup.py (path:/tmp/pip-wUPmyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:08 INFO - Running setup.py (path:/tmp/pip-iBZs9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Running setup.py (path:/tmp/pip-LsC3m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Running setup.py (path:/tmp/pip-6ey0MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Running setup.py (path:/tmp/pip-oFFiBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Running setup.py (path:/tmp/pip-lt96Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Running setup.py (path:/tmp/pip-GEcXDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Running setup.py (path:/tmp/pip-645q8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Running setup.py (path:/tmp/pip-yiKa0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Running setup.py (path:/tmp/pip-InlAww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:09 INFO - Running setup.py install for manifestparser 10:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:09 INFO - Running setup.py install for mozcrash 10:16:09 INFO - Running setup.py install for mozdebug 10:16:09 INFO - Running setup.py install for mozdevice 10:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozfile 10:16:10 INFO - Running setup.py install for mozhttpd 10:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozinfo 10:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozInstall 10:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozleak 10:16:10 INFO - Running setup.py install for mozlog 10:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for moznetwork 10:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozprocess 10:16:10 INFO - Running setup.py install for mozprofile 10:16:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozrunner 10:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozscreenshot 10:16:11 INFO - Running setup.py install for moztest 10:16:11 INFO - Running setup.py install for mozversion 10:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:11 INFO - Cleaning up... 10:16:11 INFO - Return code: 0 10:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:11 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 10:16:11 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 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:11 INFO - Running setup.py (path:/tmp/pip-waTgka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:11 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)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:11 INFO - Running setup.py (path:/tmp/pip-OIjlLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:11 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)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:11 INFO - Running setup.py (path:/tmp/pip-6bauXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:11 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)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:11 INFO - Running setup.py (path:/tmp/pip-d4XwS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:11 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)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:11 INFO - Running setup.py (path:/tmp/pip-0kOFNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 INFO - Running setup.py (path:/tmp/pip-esuXqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 INFO - Running setup.py (path:/tmp/pip-opbkjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:12 INFO - Running setup.py (path:/tmp/pip-tjvuIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:12 INFO - Running setup.py (path:/tmp/pip-QoIgqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:12 INFO - Running setup.py (path:/tmp/pip-DNucZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:12 INFO - Running setup.py (path:/tmp/pip-finX62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:12 INFO - Running setup.py (path:/tmp/pip-Jx7rBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:12 INFO - Running setup.py (path:/tmp/pip-fFk3Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:12 INFO - Running setup.py (path:/tmp/pip-gBiu2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:12 INFO - Running setup.py (path:/tmp/pip-rBst6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:12 INFO - Running setup.py (path:/tmp/pip-9npSSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:12 INFO - Running setup.py (path:/tmp/pip-6QnnLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:12 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)) 10:16:12 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)) 10:16:12 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)) 10:16:12 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)) 10:16:12 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)) 10:16:12 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)) 10:16:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:14 INFO - Downloading blessings-1.6.tar.gz 10:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:15 INFO - Installing collected packages: blessings 10:16:15 INFO - Running setup.py install for blessings 10:16:15 INFO - Successfully installed blessings 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:15 INFO - Reading from file tmpfile_stdout 10:16:15 INFO - Current package versions: 10:16:15 INFO - argparse == 1.2.1 10:16:15 INFO - blessings == 1.6 10:16:15 INFO - blobuploader == 1.2.4 10:16:15 INFO - docopt == 0.6.1 10:16:15 INFO - functools32 == 3.2.3-2 10:16:15 INFO - jsonschema == 2.5.1 10:16:15 INFO - manifestparser == 1.1 10:16:15 INFO - mozInstall == 1.12 10:16:15 INFO - mozcrash == 0.17 10:16:15 INFO - mozdebug == 0.1 10:16:15 INFO - mozdevice == 0.48 10:16:15 INFO - mozfile == 1.2 10:16:15 INFO - mozhttpd == 0.7 10:16:15 INFO - mozinfo == 0.9 10:16:15 INFO - mozleak == 0.1 10:16:15 INFO - mozlog == 3.2 10:16:15 INFO - moznetwork == 0.27 10:16:15 INFO - mozprocess == 0.22 10:16:15 INFO - mozprofile == 0.28 10:16:15 INFO - mozrunner == 6.11 10:16:15 INFO - mozscreenshot == 0.1 10:16:15 INFO - mozsystemmonitor == 0.3 10:16:15 INFO - moztest == 0.7 10:16:15 INFO - mozversion == 1.4 10:16:15 INFO - psutil == 3.1.1 10:16:15 INFO - requests == 1.2.3 10:16:15 INFO - wsgiref == 0.1.2 10:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:15 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 10:16:15 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 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c168f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', '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 10:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:16 INFO - Downloading/unpacking flake8 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:16:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:16:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:18 INFO - no previously-included directories found matching 'docs/_build' 10:16:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:16:18 INFO - Running setup.py install for pep8 10:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:18 INFO - no previously-included directories found matching 'docs/_build' 10:16:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:16:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:16:18 INFO - Cleaning up... 10:16:19 INFO - Return code: 0 10:16:19 INFO - Running post-action listener: _resource_record_post_action 10:16:19 INFO - Running post-action listener: _start_resource_monitoring 10:16:19 INFO - Starting resource monitoring. 10:16:19 INFO - ##### 10:16:19 INFO - ##### Finished create-virtualenv step (success) 10:16:19 INFO - ##### 10:16:19 INFO - ##### 10:16:19 INFO - ##### Running install step. 10:16:19 INFO - ##### 10:16:19 INFO - Running pre-action listener: _resource_record_pre_action 10:16:19 INFO - Running main action method: install 10:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:19 INFO - Reading from file tmpfile_stdout 10:16:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:19 INFO - Reading from file tmpfile_stdout 10:16:19 INFO - Output received: 10:16:19 INFO - Usage: mozinstall [options] installer 10:16:19 INFO - Options: 10:16:19 INFO - -h, --help show this help message and exit 10:16:19 INFO - -d DEST, --destination=DEST 10:16:19 INFO - Directory to install application into. [default: 10:16:19 INFO - "/builds/slave/test"] 10:16:19 INFO - --app=APP Application being installed. [default: firefox] 10:16:19 INFO - mkdir: /builds/slave/test/build/application 10:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:16:36 INFO - Reading from file tmpfile_stdout 10:16:36 INFO - Output received: 10:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:36 INFO - Running post-action listener: _resource_record_post_action 10:16:36 INFO - ##### 10:16:36 INFO - ##### Finished install step (success) 10:16:36 INFO - ##### 10:16:36 INFO - ##### 10:16:36 INFO - ##### Running run-tests step. 10:16:36 INFO - ##### 10:16:36 INFO - Running pre-action listener: _resource_record_pre_action 10:16:36 INFO - Running main action method: run_tests 10:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:36 INFO - Python 2.7.3 10:16:36 INFO - Return code: 0 10:16:36 INFO - grabbing minidump binary from tooltool 10:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:36 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 0x10202e0>, '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 0xf8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:36 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 10:16:36 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 10:16:36 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 10:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:36 INFO - Return code: 0 10:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:16:37 INFO - Return code: 0 10:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:16:37 INFO - Using env: {'DISPLAY': ':0', 10:16:37 INFO - 'HOME': '/home/cltbld', 10:16:37 INFO - 'LANG': 'en_US.UTF-8', 10:16:37 INFO - 'LANGUAGE': 'en_US:en', 10:16:37 INFO - 'LOGNAME': 'cltbld', 10:16:37 INFO - 'MAIL': '/var/mail/cltbld', 10:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:37 INFO - 'MOZ_NO_REMOTE': '1', 10:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:37 INFO - 'NO_EM_RESTART': '1', 10:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:37 INFO - 'PWD': '/builds/slave/test', 10:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:37 INFO - 'SHELL': '/bin/bash', 10:16:37 INFO - 'SHLVL': '1', 10:16:37 INFO - 'TERM': 'linux', 10:16:37 INFO - 'TMOUT': '86400', 10:16:37 INFO - 'USER': 'cltbld', 10:16:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268', 10:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:37 INFO - '_': '/tools/buildbot/bin/python'} 10:16:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:16:37 INFO - mozversion application_buildid: 20160603073206 10:16:37 INFO - mozversion application_changeset: 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 10:16:37 INFO - mozversion application_display_name: Nightly 10:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:37 INFO - mozversion application_name: Firefox 10:16:37 INFO - mozversion application_remotingname: firefox 10:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:16:37 INFO - mozversion application_vendor: Mozilla 10:16:37 INFO - mozversion application_version: 49.0a1 10:16:37 INFO - mozversion platform_buildid: 20160603073206 10:16:37 INFO - mozversion platform_changeset: 7f5e5e52d06fdb6c2b3ac864a310f934541ab8b9 10:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:16:37 INFO - mozversion platform_version: 49.0a1 10:16:37 INFO - using testdate: 1464974197 10:16:37 INFO - actual date: 1464974197 10:16:37 INFO - starting webserver on 'localhost:40550' 10:16:37 INFO - SUITE-START | Running 2 tests 10:16:37 INFO - TEST-START | dromaeo_css 10:16:37 INFO - operating with platform_type : linux_ 10:16:37 INFO - Initialising browser for dromaeo_css test... 10:16:37 INFO - TEST-INFO | started process 29035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRW03oD/profile http://localhost:40550/getInfo.html) 10:16:41 INFO - PROCESS | 29035 | __metrics Screen width/height:1600/1200 10:16:41 INFO - PROCESS | 29035 | colorDepth:24 10:16:41 INFO - PROCESS | 29035 | Browser inner width/height: 1024/697 10:16:41 INFO - PROCESS | 29035 | __metrics 10:16:42 ERROR - PROCESS | 29035 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:16:43 INFO - TEST-INFO | 29035: exit 0 10:16:43 INFO - Browser initialized. 10:16:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:43 INFO - TEST-INFO | started process 29120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRW03oD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:55 INFO - PROCESS | 29120 | RSS: Main: 156770304 10:16:55 INFO - PROCESS | 29120 | 10:17:46 INFO - PROCESS | 29120 | 1464974266455 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] 10:19:54 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40550/tests/dromaeo/cssquery-ext.html) 10:19:55 INFO - PROCESS | 29120 | RSS: Main: 254267392 10:19:55 INFO - PROCESS | 29120 | 10:22:57 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-ext.html (next: http://localhost:40550/tests/dromaeo/cssquery-jquery.html) 10:22:58 INFO - PROCESS | 29120 | RSS: Main: 243134464 10:22:58 INFO - PROCESS | 29120 | 10:26:00 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40550/tests/dromaeo/cssquery-mootools.html) 10:26:01 INFO - PROCESS | 29120 | RSS: Main: 252104704 10:26:01 INFO - PROCESS | 29120 | 10:29:03 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40550/tests/dromaeo/cssquery-prototype.html) 10:29:03 INFO - PROCESS | 29120 | RSS: Main: 241446912 10:29:03 INFO - PROCESS | 29120 | 10:32:06 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40550/tests/dromaeo/cssquery-yui.html) 10:32:07 INFO - PROCESS | 29120 | RSS: Main: 223952896 10:32:07 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | Cycle 1(1): loaded http://localhost:40550/tests/dromaeo/cssquery-yui.html (next: http://localhost:40550/tests/dromaeo/cssquery-dojo.html) 10:35:10 INFO - PROCESS | 29120 | RSS: Main: 273907712 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | __start_tp_report 10:35:10 INFO - PROCESS | 29120 | _x_x_mozilla_page_load 10:35:10 INFO - PROCESS | 29120 | _x_x_mozilla_page_load_details 10:35:10 INFO - PROCESS | 29120 | |i|pagename|runs| 10:35:10 INFO - PROCESS | 29120 | |0;dojo.html;3103.5499852521393;3113.1750086227153;3114.4705400081984;3157.8894738684153;3184.5064015077655;5304.177852432869;5339.199120131982;5344.438833922441;5440.755166017529;5491.28613280273;5386.111291636885;5399.514043736063;5415.970965516549;5440.700761458118;5466.617336786427;4876.049170411762;4931.26031095335;4964.702117872921;4981;5061.139606266925;4975.452700202993;4998.175301075318;5013.47358527353;5027.547520723134;5043.596512279028;4818.325434439182;4882.731449770261;4915.901681966358;4916.041371932439;4920.040592084545;4876.097921884428;4920.532549407801;4933.260010998343;4988.077205716954;5021.221710634857;4930.260460930853;4963.503649635044;4970.577500912426;4973.52751488608;5016.598672106223;5224.712640804754;5241.082810508184;5291.523762861322;5365.946340536584;5366.651167674088;5751.769929202868;5805.390434004453;5810.709464526757;5814.331351894544;5830.737616807254;5629.296337957755;5756.30924289088;5797.36229014808;5835.387284335168;5850.385709500526;5415.891682166334;5461.508464238238;5484.204790305424;5501.4223506532035;5510.752016159242;5985.730642121115;6009.459148676553;6010.639361638316;6012.458878700851;6026.156338112668;5520.806771762969;5635.774569017193;5683.232763576947;5750.396208398141;5798.710064496759;5745.741441635137;5810.854728631733;5812.88374232513;5865.061590145641;5868.471837534642;5721.828345149652;5731.684757338387;5734.455226753452;5785.942140578624;5802.941970580325;5637.774489020475;5734.971325143348;5779.162021506858;5800.8259752207505;5804.680742559115;4397.098594788061;4431.379606855043;4434.645228381722;4440.600345968878;4480.596746292849;3928.03763078042;3943.2902077626304;3960.9009774755286;4000.3199456092534;4004.019015341202;5426.2674538936735;5433.809816656398;5496.1755736639825;5552;5564.888702226014;5828.242328497268;5830.329512106077;5866.73599688015;5885.205497257815;5935.73289201987;5574.968630803314;5582.330120385498;5588.189712491666;5588.580856435702;5589.049861523551;4773.164696178155;4817.325574419584;4828.66199366041;4829.517048295213;4867.245576935581;5770.682612456355;5780.94219057804;5781.913271300934;5781.971090144522;5802.593818432669;5677.063284558001;5696;5708.058170401837;5711.286089238845;5763.308402991668;5978.790742323998;6020.307664618625;6041.697915104315;6061.121137435135;6064.423879731418;5785.537157027344;5790.131480277992;5792.536597072309;5794.391588883275;5794.478496935296;5689.516391106802;5736.8239510901;5886.175935369138;5899.734511946886;5903.852403689943;5638.5489160867855;5673.77304907799;5684.317881854204;5739.995500787429;5740.885182296247;5532.031894418541;5579.4978451937895;5580.079286917613;5586.385497595343;5600.747966341606;5408;5424.918626220531;5461.044317244387;5462.6995515247045;5513.641613295284;5645.096784514458;5694.715264236689;5742.913856292243;5750.942490575041;5760.94239057604;5606.131049687305;5613.354464236501;5618.438156184349;5620.775168993195;5660.745266462936 10:35:10 INFO - PROCESS | 29120 | |1;ext.html;592.8843875444287;618.5948203926429;626.949844012479;644.1593720195145;644.226927686776;35675.821620891926;43105.568944310544;44478.55521444784;44630.33054504181;48110;43234;43755.34366984498;43788.3431748524;43842;43947;8143.144969778177;8686.261667758248;8845;8853.73438796834;10596.31123976939;10284.280100392976;10655.30740501865;10671.146308295356;10704.411257380842;10728.570857165743;10690.251682382237;10774.676759697182;10775.461226938622;10775.461226938662;10778.137748980102;8142.715004974827;10526.684199474028;10639.680809575686;10829.29609575375;10839.458027098692;10586.36481811086;10650.201234907412;10693.946530267376;10697.732556686067;10715.30350527221;42247.366289505684;42660.57339426597;42743.57256427427;42793.14413711708;42848.35727464059;3548.556430446194;3566.821658917044;3616.692581130607;3637;3684.5394325709285;32621.673783262337;32857.835710821295;32900.50649240263;32965;34226.82886585576;4392.275274579691;4439.489458712224;4475.485319188302;4479.888002799924;4606.516315786827;328185;330081;330092;331059;331245;60880.391196088356;61150.38849611536;61504;61603.6919815407;61629;32627.34745305128;33323.83338083343;64802.67598661977;65243.496997845854;65477.67261163759;17300.22149003298;17740.46778596644;17745.7338139928;17753.467395978143;17763.644727105642;12832.230066196058;12946.158499697489;12947.5468358607;12953.805692914613;12962.351882405843;20104.296349627693;20284.492887677632;20459.4885127873;20495.487612809502;20510.282140125026;5933.851653708692;7077.363037326665;7117;7197.100362454693;7292.817679558054;998.1465846701111;1055.672741450153;1130.4573804573852;1180.5513904716154;1201.6755476021426;32462;33618.8319058408;34329.82835085859;36152;36476.27047459036;1102.6802227354137;1141.8972292493715;1151.9136064795173;1153.1524329617723;1179.9587014454453;18034.458966231035;18308.359207427675;18462.907685461487;19125.42623721263;19289.131989060246;585919;586859;591671;591823;592527;61043.99999999911;61249.38750612437;61662.69168654128;61778;61790.69104654448;1254.6737848159544;1377.2838124175373;1398.3427788939182;1439.6688761584685;1445.132920247864;32894.34211315808;34050.829745851115;34094.147646309044;34127.93106719076;34214.14464638404;51910.480895190565;52799;52911.470885290655;52967.47032529779;52981;440450;452711;453386;453838;454651;25374.365640859127;26107.216783496526;27656.170314890587;28117.578236326062;28820;48178.27732584084;48374;48681.756591216814;49909;50027.24959125543;40221.59778402178;40774.59225407708;41084.58915410927;41631;42151.7892410536;41146.58853411428;41271.7936410316;41378.1724365517;41472;41579.584204157574;40339.193216134925;40669.1866162681;41606;41676.79161604172;41834.37248441337;32884.83557582197;36595.451068233466;36792.160391980826;36874.63125368712;36967.81516092402;27823.721762782112;28009.299767505974;28155.71844281531;28232;28235.15294541167 10:35:10 INFO - PROCESS | 29120 | |2;jquery.html;397.1104725415069;401.4660501532961;402.6255582308452;404.2945060868784;422.2315385997484;12770.744585108316;17960.281588736452;19453.70819437708;19527.511812204702;20186.293479728174;15545.689086218268;17948.282068717268;18767.43697689068;18781.34265300715;19452.416427507163;5630.296212973379;5831.970840145815;5832.883342333151;5834.387389324123;5836.416358364172;5565.220869078312;5729;5784.3058832940105;5789.334226563957;5851.180834683148;5782.277215348082;5816;5828.766849326022;5837.182794408786;5839.299284085916;5635.915461268084;5702.144678298247;5795.275590551181;5795.652260864362;5800.1299805029375;5163.432022477525;5188.610854185951;5193.558547523465;5200.765965531522;5208.2968799212;22162.77837221623;22496.662550061763;23111.7688823113;23595.76404235953;23615.527689446113;2500.4499010217723;2562.666853309058;2691.4078902641386;2865.398266364066;3221.774475786696;14672.19302938338;14698.265086745727;14731.705365892622;14750.778738318933;15037.924810375987;1934.9903250483799;2019.717239586459;2028.9695654565194;2036.3890832750265;2061.938141855747;54726.452735472536;62275.688621557056;85579.5721021391;85930.57034714786;86844;10425.635102771366;10564.841527377095;10884.129269658566;10912.23614347004;11129.332240065622;15430.074195548303;15499.457518986781;15536.456224032105;15561;15602.609934751723;8287.50274983503;8288.544130072903;8357.164283571716;8535.146485351539;8538.712595650719;7261.491695581259;8215.835683286301;8242.093369729326;8363.498190108612;8381.413301068867;6130.448259656652;6574.934250657432;6614.437772789367;6620.238672552622;6761.323867613298;1920.932767353136;1963.2735887721635;1967.478618166187;1982.8413726901813;1984.781674015857;875.3216257400438;982.6811164930234;1031.9896801032044;1083.1389045708681;1109.1293334732197;17978.730319045226;18117;18141.183646735928;18215.63568728618;19501.609967800847;990.8216521026285;1009.6112996496255;1015.4668798880647;1049.742813010802;1069.823479125951;10461.738456538647;11232;11253.493592788343;11259.774804503864;11337.093032557375;489762;495875;500748;500926;500930;97097.51451242699;97578.512107439;97805;98326.5083674577;99381;1038.3043360948184;1050.1074087025968;1056.3239526702916;1059.4596755654518;1070.4433694478828;17362.913185434496;17601.735973960658;17740.55648608795;17757.46727598174;18122.81877181264;43327.35008974805;43397.18343477822;44996.77501612471;45215;45350.09299814051;59947.40052599592;60476.92131940567;61666.383336166065;61910;62004.379956201665;8535.445196062235;8598.183172598594;8743.781405464913;8876.51179185151;9032.683856065269;9954.502274886372;13613.251271180181;13805.102668326526;13899.930500347433;13947.232902190477;11747.706307342385;11934.940325298665;12002.699932501408;12129.696757580778;12499.250044997329;11750.94124529372;11866.821997670215;12120.696982575506;12237.449314780679;12335.568255111028;11161.497732602214;11327.433628318717;11442;11844.09819594205;12539.74920501603;8199.672013119409;8210.137935516685;8275.62759675828;8594.054653988182;8597.785055373666;10439.164866810484;10569.101626361846;10700.197485188797;10897.455127243447;11062.944685276521 10:35:10 INFO - PROCESS | 29120 | |3;mootools.html;1314.2377421095766;1458.3947661720385;1464.7583148780454;1648;1819.4359748477973;8334.124916883724;8706.172913573208;8712.085231050743;8957.686480973167;8967.058458861824;8608.784780380494;8804.64781408743;8814.823703525926;8823.426477278988;8825.382223244376;2089.2061016813664;2323.105604342332;2377.41753270449;2388.4028992751814;2403.086827005744;2436.3909022744315;2444.4133407982044;2450.0934654177977;2452.3623857796924;2456.852588844675;2363.7990770784504;2410.80713542917;2412.457197130649;2423.0792298926385;2424.066734307287;2051.9589608207903;2313.791758741713;2379.6073647848084;2385.940351491209;2387.3434805428474;2264.9660255096187;2291.6104262275453;2304.37781798915;2310.7920287174234;2323.303009097281;8846.071162527905;8847.911520884772;8865.423747456394;8881.777955551099;8892.510911899843;4960.379952505937;5073.949260507385;5074.162763144077;5079.923801142986;5080.060188865072;3190.1386625611185;3363.798172109681;3369.6124945631323;3398.762086653935;3409.4033544129925;1180.15029178991;1188.8276199951044;1198.1732604502952;1217.4278089298016;1225.148521777365;12221.694457638541;12260.325682087481;12282.447289871978;12291.877081229162;12303.75392492154;4449.466064072268;4550.704204226715;4626.653001024936;4628.5371462853445;4678.204705200056;10353.63762268317;10357.689269321932;10395.272330936914;10397.792044159074;10401.53193106312;4731.69243999139;5260.736963151827;5315.149576067811;5321.840344789663;5323.22813192085;4669.39297891272;4824.0834241494;4846.248831431134;4885.193942999436;4886.584640305543;3944.6449819515806;3952.8190294665474;4068.2880495913096;4144.336906095071;4153.273177193979;1295.8121072444442;1302.9739405212033;1312.3700623700677;1320.610419926124;1324.9801252981213;948.9620415183315;966.3863446711389;971.5579411367811;974.8927617962019;985.9605615775289;5616;5628.71856407178;5719.428057194247;5849.532037436995;5907.438793314628;1012.2964539644876;1019.154102095274;1065.733566608348;1089.6844206062117;1091.825307950724;4011.9799401003393;4158.334666453414;4162.895927601774;4173.8956526087095;4183.4979802423295;10502.159827213805;10759.462026898624;10819.513121909533;10842.457877106113;10853.782924341469;10607.363558186533;10678.14574834027;10685.519151638195;10689.251752377415;10691.037806597444;7820.648070836713;8107.837843243102;8125.187481251827;8310.626021829032;8316.584170791557;5791.942080579309;6008.579399441997;6086.482648974887;6115.877682446415;6201.255849297932;9801.31390802637;10025.498725063864;10103.747406314607;10217.795644086927;10249.487525623837;9792.951035244778;10110.79778404413;10370.740731481774;10387.220958427997;10388.11701005423;6818.761343352959;7573.6213189341415;7603.20166382544;7737.381009519338;7799.805004874924;8645.178708022728;8681.739547813575;8754.387192896691;8764.474131552128;8773.034966153846;7572.659230334538;7750.8837367440665;7799.45403821727;7869.370450364072;7879.448438609243;7632.542047477169;7758.495697779626;7761.068671759425;7894.328982036591;7901.0518737749535;7173.964130179315;7183.425325973805;7248.637568121679;7258.165310989304;7258.600776957107;4777.402824646919;4908.950910490849;4927.679700819435;4939.678920870132;5021.748912554431;5017.84946451607;5118.923216151835;5179.637425380187;5198.844034678966;5305.946940530545 10:35:10 INFO - PROCESS | 29120 | |4;prototype.html;316.86216495824317;320.2889585121032;327.1738859380065;331.5457822782788;332.2673504921648;5338.932213557285;5340.62615616907;5376.623636345453;5416.4312747161575;5421.620486565932;5234.450382709818;5239.842804715865;5256.290400795891;5279.313689220396;5290.724988255049;3899.278633452806;4018.8995275118064;4028.4561584186054;4038.6163314485075;4073.368627862686;4085.632293093621;4089.9386509202386;4095.2219078375015;4097.7541347519245;4101;3970.7617542947373;4048.8785336439955;4052.642364807793;4052.8581499647516;4080.2655522006025;3995.720299579031;4060.309747342959;4080.9591904080876;4094.2425651254466;4098.262312783698;3560.2523470071055;3565.8217089145437;3571.6964058055096;3571.94642080369;3582.6775590197008;5085.169339037943;5099.674084737958;5112.897742045176;5132.178851383761;5155.0978578748945;4487.730736155841;4631.143238500888;4648.163330600491;4700.694454860457;4709.387779588666;5476.26070480484;5519.39286678465;5538.452311936514;5552.805651802168;5564.8330550083565;3942.1524372259814;3942.5071866016747;3945.948106984352;3952.249072676211;3954.8615798446917;5531.695756733378;5749.59752817303;5765.6540607563265;5781.306243250837;5799.21710569072;3982.761034337949;3994.6205110514456;4017.5580686124504;4019.437278780973;4025.355943049098;4075.918481630351;4078.1028173801715;4082.1835632873544;4097.795110244476;4106.1582375612925;4671.556202160789;4683.81264749413;4694.81220751173;4713.905721885543;4716.575508204278;5321.201819727072;5533.253010843485;5551.639143455663;5565.805196818092;5592.972035139798;1377.1805775563723;1397.7623803953352;1399.237415608496;1403.6350548857167;1408.204364534035;898.4564338575068;902.8871391076116;905.9365844390961;909.8316811389914;941.8540126280437;5313.635432232697;5333.466653334713;5358.91961620576;5374.6506477078865;5401.810936617199;5707.857303567444;5733.741981610838;5745.741441635137;5747.109198074305;5750.1949727038245;5112.565431938327;5284.5772338212855;5295.602829787781;5325;5352.197170424468;2989.7159769821833;3006.9248268793453;3024.6672865984724;3047.5581040748966;3065.693430656961;5816.534677225896;5829.854253643693;5850.385709500526;5866.560007999417;5878.677297608004;5604.747786349624;5905.320888097838;5907.734151963086;5916.467517923407;5953.374895635982;5949.553783466257;5959.523238140939;5973.671448070311;5986.8026394720355;5987.6108052976415;5568.498835104698;5752.928945579504;5779.537636989115;5787.8553036174435;5790.623609465371;5677.716114194356;5710.314762228559;5735.397783232867;5738.302997591126;5741.167530708108;5846.56150788684;5868.794592189253;5981.850453738692;6005.6396616203165;6034.849128771816;4125.525564560114;4135.214309281227;4146.419501269765;4148.8133034014145;4159.958400415957;5786.218860453785;5808.912866306924;5820.854478638068;5862.824115276549;5879.794207202727;5621.7189140542;5683.261176047087;5722.914156287576;5752.7698892043845;5764.337101233412;5626.831195064155;5640.915386269291;5661.716914154358;5675.4040825714355;5676.886462270649;5290.523852853262;5297;5533.889322213453;5541.695206763667;5609.775608975759;5606.24315717373;5669.659820410624;5675.233843431084;5677.091665333527;5706.572007099401;5523.906612297126;5542.7782888684005;5551.528120109836;5585.497305242548;5589.323203038991 10:35:10 INFO - PROCESS | 29120 | |5;yui.html;750.6096829648583;778.8559116563437;812.1513018895254;840.4579046514995;852.9147085291472;13729.931350343248;15140;15475.84524154758;15490.535283941472;15505.534833954971;14576.708465830678;15267.465638702648;15306.617334566641;15711.057336559814;15727.685446291067;668.5787953589232;793.5119901260712;815.4210510537511;816.0493025625169;821.7000794709918;807.2653884964683;819.6229734322189;820.0569345252977;820.5281962871343;820.9384296177781;855.3969451536652;859.5530324231396;860.2172023458654;860.384824850232;860.9139086091403;702.6978399288304;812.5368539932241;834.1033389106674;846.5301757524571;847.1655419411875;615.0681717198448;615.5352708704944;616.2450997528038;616.312811215496;616.4698359410903;14593;14653.926730366387;14661.120332779961;14677.633059173499;14691.338889749986;13949.860501394958;14184.219867907364;14206.715865682629;14435.927820360936;14554;13158.342082895817;13349.66625834362;13359.465621375133;13494;13658.726825463535;4486.820527178909;4526.117407105616;4562.498125206224;4627;4646.070785842811;79770;81557.59221203915;81563.59218203872;81672;81879.5906020472;10429.739256518647;10434.634787782392;10565.735856603646;11285.717857053474;11481.655550333504;19804.801951980295;20095.698564521543;20140.597188056156;20169.697454538193;20329.085191166432;8549.529775862387;8595.613197406132;8607.61265743043;8787.165219304155;8804.823903521894;4604.907901841944;4712.9080818971115;4722.693024953367;4722.811087556528;4821.9035619287415;3405.4891766235264;3503.684668379858;3517.8944631661093;3518;3520.2079532105586;624.7938180400457;633.4425705379236;636.0618088319692;643.6106155775782;645.7965740791635;565.3300838506383;621.3631028196045;697.9895301570481;706.6713978000255;780.9687612495436;9929.80140397188;10629.4153821539;10669.413182274895;10731.624393146203;10741.51663175159;601.6119602856133;668.4785867023729;692.6052150274295;703.0719450325623;775.1707751707708;4715;4773.212419950669;4860.198067318924;4864.318995340655;4960.528749768766;101141;107206.46396768122;110640;111645;113814;80506.19493804987;92511.53744231236;94269;94516;95181;56653.43346566481;63409.68295158587;86798;89379;90531.54734226418;10300.124489418484;10562.78874422492;10607.151427885905;10609.787804243717;10721.195910306602;44833.87915302144;53659.73170134125;53779;55503;55981;51277.7436112817;52171;59310;68596.65701671659;75420.62289688736;12793.872061279268;13003.544875929298;13451.058425910092;13517.391717372939;13700.24648644334;14929.552113436614;14981.052463179716;15451.922740386226;15516.456924007605;15667.451639192574;14547.78178327347;14567.635809104857;14601.780973285197;14903.85096149068;15268.77096843526;13569.93215033958;13587.252701101534;14041.36813843359;14367.640808979859;14368.425262989364;12439.502419903465;12982.221066736027;13090.934545327213;13193.076484645982;13520.526781562598;11314.626272659549;11636.476358564054;11832.76334473323;11961.700957476132;12041.879581204426;10846.857949293846;12102.24930593833;12164.148509604243;12317.137800353888;12460.376981150725 10:35:10 INFO - PROCESS | 29120 | __end_tp_report 10:35:10 INFO - PROCESS | 29120 | __start_cc_report 10:35:10 INFO - PROCESS | 29120 | _x_x_mozilla_cycle_collect,893 10:35:10 INFO - PROCESS | 29120 | __end_cc_report 10:35:10 INFO - PROCESS | 29120 | __startTimestamp1464975310438__endTimestamp 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | ------- Summary: start ------- 10:35:10 INFO - PROCESS | 29120 | Number of tests: 6 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#0] dojo.html Cycles:165 Average:5378.00 Median:5588.19 stddev:609.69 (10.9%) stddev-sans-first:584.87 10:35:10 INFO - PROCESS | 29120 | Values: 3103.5 3113.2 3114.5 3157.9 3184.5 5304.2 5339.2 5344.4 5440.8 5491.3 5386.1 5399.5 5416.0 5440.7 5466.6 4876.0 4931.3 4964.7 4981.0 5061.1 4975.5 4998.2 5013.5 5027.5 5043.6 4818.3 4882.7 4915.9 4916.0 4920.0 4876.1 4920.5 4933.3 4988.1 5021.2 4930.3 4963.5 4970.6 4973.5 5016.6 5224.7 5241.1 5291.5 5365.9 5366.7 5751.8 5805.4 5810.7 5814.3 5830.7 5629.3 5756.3 5797.4 5835.4 5850.4 5415.9 5461.5 5484.2 5501.4 5510.8 5985.7 6009.5 6010.6 6012.5 6026.2 5520.8 5635.8 5683.2 5750.4 5798.7 5745.7 5810.9 5812.9 5865.1 5868.5 5721.8 5731.7 5734.5 5785.9 5802.9 5637.8 5735.0 5779.2 5800.8 5804.7 4397.1 4431.4 4434.6 4440.6 4480.6 3928.0 3943.3 3960.9 4000.3 4004.0 5426.3 5433.8 5496.2 5552.0 5564.9 5828.2 5830.3 5866.7 5885.2 5935.7 5575.0 5582.3 5588.2 5588.6 5589.0 4773.2 4817.3 4828.7 4829.5 4867.2 5770.7 5780.9 5781.9 5782.0 5802.6 5677.1 5696.0 5708.1 5711.3 5763.3 5978.8 6020.3 6041.7 6061.1 6064.4 5785.5 5790.1 5792.5 5794.4 5794.5 5689.5 5736.8 5886.2 5899.7 5903.9 5638.5 5673.8 5684.3 5740.0 5740.9 5532.0 5579.5 5580.1 5586.4 5600.7 5408.0 5424.9 5461.0 5462.7 5513.6 5645.1 5694.7 5742.9 5750.9 5760.9 5606.1 5613.4 5618.4 5620.8 5660.7 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#1] ext.html Cycles:180 Average:62061.37 Median:20056.64 stddev:124640.26 (621.4%) stddev-sans-first:124904.47 10:35:10 INFO - PROCESS | 29120 | Values: 592.9 618.6 626.9 644.2 644.2 35675.8 43105.6 44478.6 44630.3 48110.0 43234.0 43755.3 43788.3 43842.0 43947.0 8143.1 8686.3 8845.0 8853.7 10596.3 10284.3 10655.3 10671.1 10704.4 10728.6 10690.3 10774.7 10775.5 10775.5 10778.1 8142.7 10526.7 10639.7 10829.3 10839.5 10586.4 10650.2 10693.9 10697.7 10715.3 42247.4 42660.6 42743.6 42793.1 42848.4 3548.6 3566.8 3616.7 3637.0 3684.5 32621.7 32857.8 32900.5 32965.0 34226.8 4392.3 4439.5 4475.5 4479.9 4606.5 328185.0 330081.0 330092.0 331059.0 331245.0 60880.4 61150.4 61504.0 61603.7 61629.0 32627.3 33323.8 64802.7 65243.5 65477.7 17300.2 17740.5 17745.7 17753.5 17763.6 12832.2 12946.2 12947.5 12953.8 12962.4 20104.3 20284.5 20459.5 20495.5 20510.3 5933.9 7077.4 7117.0 7197.1 7292.8 998.1 1055.7 1130.5 1180.6 1201.7 32462.0 33618.8 34329.8 36152.0 36476.3 1102.7 1141.9 1151.9 1153.2 1180.0 18034.5 18308.4 18462.9 19125.4 19289.1 585919.0 586859.0 591671.0 591823.0 592527.0 61044.0 61249.4 61662.7 61778.0 61790.7 1254.7 1377.3 1398.3 1439.7 1445.1 32894.3 34050.8 34094.1 34127.9 34214.1 51910.5 52799.0 52911.5 52967.5 52981.0 440450.0 452711.0 453386.0 453838.0 454651.0 25374.4 26107.2 27656.2 28117.6 28820.0 48178.3 48374.0 48681.8 49909.0 50027.2 40221.6 40774.6 41084.6 41631.0 42151.8 41146.6 41271.8 41378.2 41472.0 41579.6 40339.2 40669.2 41606.0 41676.8 41834.4 32884.8 36595.5 36792.2 36874.6 36967.8 27823.7 28009.3 28155.7 28232.0 28235.2 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#2] jquery.html Cycles:180 Average:29502.09 Median:13057.99 stddev:82092.29 (628.7%) stddev-sans-first:82293.49 10:35:10 INFO - PROCESS | 29120 | Values: 397.1 401.5 402.6 404.3 422.2 12770.7 17960.3 19453.7 19527.5 20186.3 15545.7 17948.3 18767.4 18781.3 19452.4 5630.3 5832.0 5832.9 5834.4 5836.4 5565.2 5729.0 5784.3 5789.3 5851.2 5782.3 5816.0 5828.8 5837.2 5839.3 5635.9 5702.1 5795.3 5795.7 5800.1 5163.4 5188.6 5193.6 5200.8 5208.3 22162.8 22496.7 23111.8 23595.8 23615.5 2500.4 2562.7 2691.4 2865.4 3221.8 14672.2 14698.3 14731.7 14750.8 15037.9 1935.0 2019.7 2029.0 2036.4 2061.9 54726.5 62275.7 85579.6 85930.6 86844.0 10425.6 10564.8 10884.1 10912.2 11129.3 15430.1 15499.5 15536.5 15561.0 15602.6 8287.5 8288.5 8357.2 8535.1 8538.7 7261.5 8215.8 8242.1 8363.5 8381.4 6130.4 6574.9 6614.4 6620.2 6761.3 1920.9 1963.3 1967.5 1982.8 1984.8 875.3 982.7 1032.0 1083.1 1109.1 17978.7 18117.0 18141.2 18215.6 19501.6 990.8 1009.6 1015.5 1049.7 1069.8 10461.7 11232.0 11253.5 11259.8 11337.1 489762.0 495875.0 500748.0 500926.0 500930.0 97097.5 97578.5 97805.0 98326.5 99381.0 1038.3 1050.1 1056.3 1059.5 1070.4 17362.9 17601.7 17740.6 17757.5 18122.8 43327.4 43397.2 44996.8 45215.0 45350.1 59947.4 60476.9 61666.4 61910.0 62004.4 8535.4 8598.2 8743.8 8876.5 9032.7 9954.5 13613.3 13805.1 13899.9 13947.2 11747.7 11934.9 12002.7 12129.7 12499.3 11750.9 11866.8 12120.7 12237.4 12335.6 11161.5 11327.4 11442.0 11844.1 12539.7 8199.7 8210.1 8275.6 8594.1 8597.8 10439.2 10569.1 10700.2 10897.5 11062.9 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#3] mootools.html Cycles:180 Average:5800.25 Median:4627.60 stddev:3276.00 (70.8%) stddev-sans-first:3267.84 10:35:10 INFO - PROCESS | 29120 | Values: 1314.2 1458.4 1464.8 1648.0 1819.4 8334.1 8706.2 8712.1 8957.7 8967.1 8608.8 8804.6 8814.8 8823.4 8825.4 2089.2 2323.1 2377.4 2388.4 2403.1 2436.4 2444.4 2450.1 2452.4 2456.9 2363.8 2410.8 2412.5 2423.1 2424.1 2052.0 2313.8 2379.6 2385.9 2387.3 2265.0 2291.6 2304.4 2310.8 2323.3 8846.1 8847.9 8865.4 8881.8 8892.5 4960.4 5073.9 5074.2 5079.9 5080.1 3190.1 3363.8 3369.6 3398.8 3409.4 1180.2 1188.8 1198.2 1217.4 1225.1 12221.7 12260.3 12282.4 12291.9 12303.8 4449.5 4550.7 4626.7 4628.5 4678.2 10353.6 10357.7 10395.3 10397.8 10401.5 4731.7 5260.7 5315.1 5321.8 5323.2 4669.4 4824.1 4846.2 4885.2 4886.6 3944.6 3952.8 4068.3 4144.3 4153.3 1295.8 1303.0 1312.4 1320.6 1325.0 949.0 966.4 971.6 974.9 986.0 5616.0 5628.7 5719.4 5849.5 5907.4 1012.3 1019.2 1065.7 1089.7 1091.8 4012.0 4158.3 4162.9 4173.9 4183.5 10502.2 10759.5 10819.5 10842.5 10853.8 10607.4 10678.1 10685.5 10689.3 10691.0 7820.6 8107.8 8125.2 8310.6 8316.6 5791.9 6008.6 6086.5 6115.9 6201.3 9801.3 10025.5 10103.7 10217.8 10249.5 9793.0 10110.8 10370.7 10387.2 10388.1 6818.8 7573.6 7603.2 7737.4 7799.8 8645.2 8681.7 8754.4 8764.5 8773.0 7572.7 7750.9 7799.5 7869.4 7879.4 7632.5 7758.5 7761.1 7894.3 7901.1 7174.0 7183.4 7248.6 7258.2 7258.6 4777.4 4909.0 4927.7 4939.7 5021.7 5017.8 5118.9 5179.6 5198.8 5305.9 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#4] prototype.html Cycles:180 Average:4689.27 Median:5346.41 stddev:1403.94 (26.3%) stddev-sans-first:1368.99 10:35:10 INFO - PROCESS | 29120 | Values: 316.9 320.3 327.2 331.5 332.3 5338.9 5340.6 5376.6 5416.4 5421.6 5234.5 5239.8 5256.3 5279.3 5290.7 3899.3 4018.9 4028.5 4038.6 4073.4 4085.6 4089.9 4095.2 4097.8 4101.0 3970.8 4048.9 4052.6 4052.9 4080.3 3995.7 4060.3 4081.0 4094.2 4098.3 3560.3 3565.8 3571.7 3571.9 3582.7 5085.2 5099.7 5112.9 5132.2 5155.1 4487.7 4631.1 4648.2 4700.7 4709.4 5476.3 5519.4 5538.5 5552.8 5564.8 3942.2 3942.5 3945.9 3952.2 3954.9 5531.7 5749.6 5765.7 5781.3 5799.2 3982.8 3994.6 4017.6 4019.4 4025.4 4075.9 4078.1 4082.2 4097.8 4106.2 4671.6 4683.8 4694.8 4713.9 4716.6 5321.2 5533.3 5551.6 5565.8 5593.0 1377.2 1397.8 1399.2 1403.6 1408.2 898.5 902.9 905.9 909.8 941.9 5313.6 5333.5 5358.9 5374.7 5401.8 5707.9 5733.7 5745.7 5747.1 5750.2 5112.6 5284.6 5295.6 5325.0 5352.2 2989.7 3006.9 3024.7 3047.6 3065.7 5816.5 5829.9 5850.4 5866.6 5878.7 5604.7 5905.3 5907.7 5916.5 5953.4 5949.6 5959.5 5973.7 5986.8 5987.6 5568.5 5752.9 5779.5 5787.9 5790.6 5677.7 5710.3 5735.4 5738.3 5741.2 5846.6 5868.8 5981.9 6005.6 6034.8 4125.5 4135.2 4146.4 4148.8 4160.0 5786.2 5808.9 5820.9 5862.8 5879.8 5621.7 5683.3 5722.9 5752.8 5764.3 5626.8 5640.9 5661.7 5675.4 5676.9 5290.5 5297.0 5533.9 5541.7 5609.8 5606.2 5669.7 5675.2 5677.1 5706.6 5523.9 5542.8 5551.5 5585.5 5589.3 10:35:10 INFO - PROCESS | 29120 | 10:35:10 INFO - PROCESS | 29120 | [#5] yui.html Cycles:180 Average:20136.61 Median:4506.47 stddev:28143.10 (624.5%) stddev-sans-first:28184.40 10:35:10 INFO - PROCESS | 29120 | Values: 750.6 778.9 812.2 840.5 852.9 13729.9 15140.0 15475.8 15490.5 15505.5 14576.7 15267.5 15306.6 15711.1 15727.7 668.6 793.5 815.4 816.0 821.7 807.3 819.6 820.1 820.5 820.9 855.4 859.6 860.2 860.4 860.9 702.7 812.5 834.1 846.5 847.2 615.1 615.5 616.2 616.3 616.5 14593.0 14653.9 14661.1 14677.6 14691.3 13949.9 14184.2 14206.7 14435.9 14554.0 13158.3 13349.7 13359.5 13494.0 13658.7 4486.8 4526.1 4562.5 4627.0 4646.1 79770.0 81557.6 81563.6 81672.0 81879.6 10429.7 10434.6 10565.7 11285.7 11481.7 19804.8 20095.7 20140.6 20169.7 20329.1 8549.5 8595.6 8607.6 8787.2 8804.8 4604.9 4712.9 4722.7 4722.8 4821.9 3405.5 3503.7 3517.9 3518.0 3520.2 624.8 633.4 636.1 643.6 645.8 565.3 621.4 698.0 706.7 781.0 9929.8 10629.4 10669.4 10731.6 10741.5 601.6 668.5 692.6 703.1 775.2 4715.0 4773.2 4860.2 4864.3 4960.5 101141.0 107206.5 110640.0 111645.0 113814.0 80506.2 92511.5 94269.0 94516.0 95181.0 56653.4 63409.7 86798.0 89379.0 90531.5 10300.1 10562.8 10607.2 10609.8 10721.2 44833.9 53659.7 53779.0 55503.0 55981.0 51277.7 52171.0 59310.0 68596.7 75420.6 12793.9 13003.5 13451.1 13517.4 13700.2 14929.6 14981.1 15451.9 15516.5 15667.5 14547.8 14567.6 14601.8 14903.9 15268.8 13569.9 13587.3 14041.4 14367.6 14368.4 12439.5 12982.2 13090.9 13193.1 13520.5 11314.6 11636.5 11832.8 11961.7 12041.9 10846.9 12102.2 12164.1 12317.1 12460.4 10:35:10 INFO - PROCESS | 29120 | -------- Summary: end -------- 10:35:10 INFO - PROCESS | 29120 | 10:35:11 INFO - TEST-INFO | 29120: exit 0 10:35:11 INFO - TEST-OK | dromaeo_css | took 1113772ms 10:35:11 INFO - TEST-START | kraken 10:35:11 INFO - operating with platform_type : linux_ 10:35:11 INFO - Initialising browser for kraken test... 10:35:11 INFO - TEST-INFO | started process 29304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpweJoD4/profile http://localhost:40550/getInfo.html) 10:35:15 INFO - PROCESS | 29304 | __metrics Screen width/height:1600/1200 10:35:15 INFO - PROCESS | 29304 | colorDepth:24 10:35:15 INFO - PROCESS | 29304 | Browser inner width/height: 1024/697 10:35:15 INFO - PROCESS | 29304 | __metrics 10:35:16 ERROR - PROCESS | 29304 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:35:17 INFO - TEST-INFO | 29304: exit 0 10:35:17 INFO - Browser initialized. 10:35:17 INFO - Running cycle 1/1 for kraken test... 10:35:17 INFO - TEST-INFO | started process 29386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpweJoD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:28 INFO - PROCESS | 29386 | RSS: Main: 156053504 10:35:28 INFO - PROCESS | 29386 | 10:35:31 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40550/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:32 INFO - PROCESS | 29386 | RSS: Main: 214441984 10:35:32 INFO - PROCESS | 29386 | 10:35:34 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40550/tests/kraken/driver.html?testName=audio-dft) 10:35:35 INFO - PROCESS | 29386 | RSS: Main: 201449472 10:35:35 INFO - PROCESS | 29386 | 10:35:38 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40550/tests/kraken/driver.html?testName=audio-fft) 10:35:39 INFO - PROCESS | 29386 | RSS: Main: 268779520 10:35:39 INFO - PROCESS | 29386 | 10:35:41 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40550/tests/kraken/driver.html?testName=audio-oscillator) 10:35:41 INFO - PROCESS | 29386 | RSS: Main: 179654656 10:35:41 INFO - PROCESS | 29386 | 10:35:44 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:44 INFO - PROCESS | 29386 | RSS: Main: 184004608 10:35:44 INFO - PROCESS | 29386 | 10:35:47 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40550/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:48 INFO - PROCESS | 29386 | RSS: Main: 218210304 10:35:48 INFO - PROCESS | 29386 | 10:35:51 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40550/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:52 INFO - PROCESS | 29386 | RSS: Main: 221024256 10:35:52 INFO - PROCESS | 29386 | 10:35:55 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40550/tests/kraken/driver.html?testName=json-parse-financial) 10:35:55 INFO - PROCESS | 29386 | RSS: Main: 220401664 10:35:55 INFO - PROCESS | 29386 | 10:35:57 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:57 INFO - PROCESS | 29386 | RSS: Main: 205594624 10:35:57 INFO - PROCESS | 29386 | 10:35:59 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:00 INFO - PROCESS | 29386 | RSS: Main: 209518592 10:36:00 INFO - PROCESS | 29386 | 10:36:02 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:02 INFO - PROCESS | 29386 | RSS: Main: 217624576 10:36:02 INFO - PROCESS | 29386 | 10:36:05 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:06 INFO - PROCESS | 29386 | RSS: Main: 225075200 10:36:06 INFO - PROCESS | 29386 | 10:36:08 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:09 INFO - PROCESS | 29386 | RSS: Main: 224256000 10:36:09 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | Cycle 1(1): loaded http://localhost:40550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40550/tests/kraken/driver.html?testName=ai-astar) 10:36:11 INFO - PROCESS | 29386 | RSS: Main: 266575872 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | __start_tp_report 10:36:11 INFO - PROCESS | 29386 | _x_x_mozilla_page_load 10:36:11 INFO - PROCESS | 29386 | _x_x_mozilla_page_load_details 10:36:11 INFO - PROCESS | 29386 | |i|pagename|runs| 10:36:11 INFO - PROCESS | 29386 | |0;ai-astar;110;105;111;109;110;110;109;109;108;110 10:36:11 INFO - PROCESS | 29386 | |1;audio-beat-detection;148;126;126;183;128;128;152;133;159;124 10:36:11 INFO - PROCESS | 29386 | |2;audio-dft;161;160;161;161;161;161;160;161;161;160 10:36:11 INFO - PROCESS | 29386 | |3;audio-fft;74;74;76;121;75;75;74;73;104;76 10:36:11 INFO - PROCESS | 29386 | |4;audio-oscillator;84;84;117;84;85;85;118;85;85;122 10:36:11 INFO - PROCESS | 29386 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;117;117;117 10:36:11 INFO - PROCESS | 29386 | |6;imaging-darkroom;146;146;146;146;145;146;146;177;146;146 10:36:11 INFO - PROCESS | 29386 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;95;95 10:36:11 INFO - PROCESS | 29386 | |8;json-parse-financial;56;55;54;54;55;60;56;54;53;55 10:36:11 INFO - PROCESS | 29386 | |9;json-stringify-tinderbox;61;61;61;62;62;62;62;62;61;62 10:36:11 INFO - PROCESS | 29386 | |10;stanford-crypto-aes;79;80;80;79;86;83;87;80;119;79 10:36:11 INFO - PROCESS | 29386 | |11;stanford-crypto-ccm;129;129;119;135;125;120;117;124;143;124 10:36:11 INFO - PROCESS | 29386 | |12;stanford-crypto-pbkdf2;162;170;161;165;162;164;164;163;164;160 10:36:11 INFO - PROCESS | 29386 | |13;stanford-crypto-sha256-iterative;63;63;64;64;63;65;63;63;62;62 10:36:11 INFO - PROCESS | 29386 | __end_tp_report 10:36:11 INFO - PROCESS | 29386 | __start_cc_report 10:36:11 INFO - PROCESS | 29386 | _x_x_mozilla_cycle_collect,1628 10:36:11 INFO - PROCESS | 29386 | __end_cc_report 10:36:11 INFO - PROCESS | 29386 | __startTimestamp1464975371301__endTimestamp 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | ------- Summary: start ------- 10:36:11 INFO - PROCESS | 29386 | Number of tests: 14 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.66 (1.5%) stddev-sans-first:1.73 10:36:11 INFO - PROCESS | 29386 | Values: 110.0 105.0 111.0 109.0 110.0 110.0 109.0 109.0 108.0 110.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:140.50 stddev:19.43 (13.8%) stddev-sans-first:20.43 10:36:11 INFO - PROCESS | 29386 | Values: 148.0 126.0 126.0 183.0 128.0 128.0 152.0 133.0 159.0 124.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:36:11 INFO - PROCESS | 29386 | Values: 161.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 160.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:16.49 (22.1%) stddev-sans-first:17.22 10:36:11 INFO - PROCESS | 29386 | Values: 74.0 74.0 76.0 121.0 75.0 75.0 74.0 73.0 104.0 76.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.50 stddev:16.68 (19.7%) stddev-sans-first:17.22 10:36:11 INFO - PROCESS | 29386 | Values: 84.0 84.0 117.0 84.0 85.0 85.0 118.0 85.0 85.0 122.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:36:11 INFO - PROCESS | 29386 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:146.00 stddev:9.84 (6.7%) stddev-sans-first:10.38 10:36:11 INFO - PROCESS | 29386 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 177.0 146.0 146.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:36:11 INFO - PROCESS | 29386 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.93 (3.5%) stddev-sans-first:2.03 10:36:11 INFO - PROCESS | 29386 | Values: 56.0 55.0 54.0 54.0 55.0 60.0 56.0 54.0 53.0 55.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 10:36:11 INFO - PROCESS | 29386 | Values: 61.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:80.00 stddev:12.24 (15.3%) stddev-sans-first:12.77 10:36:11 INFO - PROCESS | 29386 | Values: 79.0 80.0 80.0 79.0 86.0 83.0 87.0 80.0 119.0 79.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:7.89 (6.2%) stddev-sans-first:8.32 10:36:11 INFO - PROCESS | 29386 | Values: 129.0 129.0 119.0 135.0 125.0 120.0 117.0 124.0 143.0 124.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.76 (1.7%) stddev-sans-first:2.87 10:36:11 INFO - PROCESS | 29386 | Values: 162.0 170.0 161.0 165.0 162.0 164.0 164.0 163.0 164.0 160.0 10:36:11 INFO - PROCESS | 29386 | 10:36:11 INFO - PROCESS | 29386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 10:36:11 INFO - PROCESS | 29386 | Values: 63.0 63.0 64.0 64.0 63.0 65.0 63.0 63.0 62.0 62.0 10:36:11 INFO - PROCESS | 29386 | -------- Summary: end -------- 10:36:11 INFO - PROCESS | 29386 | 10:36:12 INFO - TEST-INFO | 29386: exit 0 10:36:12 INFO - TEST-OK | kraken | took 61123ms 10:36:12 INFO - SUITE-END | took 1174s 10:36:12 INFO - Completed test suite (00:19:35) 10:36:12 INFO - javascript benchmark 10:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5499852521393, 3113.1750086227153, 3114.4705400081984, 3157.8894738684153, 3184.5064015077655, 5304.177852432869, 5339.199120131982, 5344.438833922441, 5440.755166017529, 5491.28613280273, 5386.111291636885, 5399.514043736063, 5415.970965516549, 5440.700761458118, 5466.617336786427, 4876.049170411762, 4931.26031095335, 4964.702117872921, 4981.0, 5061.139606266925, 4975.452700202993, 4998.175301075318, 5013.47358527353, 5027.547520723134, 5043.596512279028, 4818.325434439182, 4882.731449770261, 4915.901681966358, 4916.041371932439, 4920.040592084545, 4876.097921884428, 4920.532549407801, 4933.260010998343, 4988.077205716954, 5021.221710634857, 4930.260460930853, 4963.503649635044, 4970.577500912426, 4973.52751488608, 5016.598672106223, 5224.712640804754, 5241.082810508184, 5291.523762861322, 5365.946340536584, 5366.651167674088, 5751.769929202868, 5805.390434004453, 5810.709464526757, 5814.331351894544, 5830.737616807254, 5629.296337957755, 5756.30924289088, 5797.36229014808, 5835.387284335168, 5850.385709500526, 5415.891682166334, 5461.508464238238, 5484.204790305424, 5501.4223506532035, 5510.752016159242, 5985.730642121115, 6009.459148676553, 6010.639361638316, 6012.458878700851, 6026.156338112668, 5520.806771762969, 5635.774569017193, 5683.232763576947, 5750.396208398141, 5798.710064496759, 5745.741441635137, 5810.854728631733, 5812.88374232513, 5865.061590145641, 5868.471837534642, 5721.828345149652, 5731.684757338387, 5734.455226753452, 5785.942140578624, 5802.941970580325, 5637.774489020475, 5734.971325143348, 5779.162021506858, 5800.8259752207505, 5804.680742559115, 4397.098594788061, 4431.379606855043, 4434.645228381722, 4440.600345968878, 4480.596746292849, 3928.03763078042, 3943.2902077626304, 3960.9009774755286, 4000.3199456092534, 4004.019015341202, 5426.2674538936735, 5433.809816656398, 5496.1755736639825, 5552.0, 5564.888702226014, 5828.242328497268, 5830.329512106077, 5866.73599688015, 5885.205497257815, 5935.73289201987, 5574.968630803314, 5582.330120385498, 5588.189712491666, 5588.580856435702, 5589.049861523551, 4773.164696178155, 4817.325574419584, 4828.66199366041, 4829.517048295213, 4867.245576935581, 5770.682612456355, 5780.94219057804, 5781.913271300934, 5781.971090144522, 5802.593818432669, 5677.063284558001, 5696.0, 5708.058170401837, 5711.286089238845, 5763.308402991668, 5978.790742323998, 6020.307664618625, 6041.697915104315, 6061.121137435135, 6064.423879731418, 5785.537157027344, 5790.131480277992, 5792.536597072309, 5794.391588883275, 5794.478496935296, 5689.516391106802, 5736.8239510901, 5886.175935369138, 5899.734511946886, 5903.852403689943, 5638.5489160867855, 5673.77304907799, 5684.317881854204, 5739.995500787429, 5740.885182296247, 5532.031894418541, 5579.4978451937895, 5580.079286917613, 5586.385497595343, 5600.747966341606, 5408.0, 5424.918626220531, 5461.044317244387, 5462.6995515247045, 5513.641613295284, 5645.096784514458, 5694.715264236689, 5742.913856292243, 5750.942490575041, 5760.94239057604, 5606.131049687305, 5613.354464236501, 5618.438156184349, 5620.775168993195, 5660.745266462936], "value": 5336.882304614569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8843875444287, 618.5948203926429, 626.949844012479, 644.1593720195145, 644.226927686776, 35675.821620891926, 43105.568944310544, 44478.55521444784, 44630.33054504181, 48110.0, 43234.0, 43755.34366984498, 43788.3431748524, 43842.0, 43947.0, 8143.144969778177, 8686.261667758248, 8845.0, 8853.73438796834, 10596.31123976939, 10284.280100392976, 10655.30740501865, 10671.146308295356, 10704.411257380842, 10728.570857165743, 10690.251682382237, 10774.676759697182, 10775.461226938622, 10775.461226938662, 10778.137748980102, 8142.715004974827, 10526.684199474028, 10639.680809575686, 10829.29609575375, 10839.458027098692, 10586.36481811086, 10650.201234907412, 10693.946530267376, 10697.732556686067, 10715.30350527221, 42247.366289505684, 42660.57339426597, 42743.57256427427, 42793.14413711708, 42848.35727464059, 3548.556430446194, 3566.821658917044, 3616.692581130607, 3637.0, 3684.5394325709285, 32621.673783262337, 32857.835710821295, 32900.50649240263, 32965.0, 34226.82886585576, 4392.275274579691, 4439.489458712224, 4475.485319188302, 4479.888002799924, 4606.516315786827, 328185.0, 330081.0, 330092.0, 331059.0, 331245.0, 60880.391196088356, 61150.38849611536, 61504.0, 61603.6919815407, 61629.0, 32627.34745305128, 33323.83338083343, 64802.67598661977, 65243.496997845854, 65477.67261163759, 17300.22149003298, 17740.46778596644, 17745.7338139928, 17753.467395978143, 17763.644727105642, 12832.230066196058, 12946.158499697489, 12947.5468358607, 12953.805692914613, 12962.351882405843, 20104.296349627693, 20284.492887677632, 20459.4885127873, 20495.487612809502, 20510.282140125026, 5933.851653708692, 7077.363037326665, 7117.0, 7197.100362454693, 7292.817679558054, 998.1465846701111, 1055.672741450153, 1130.4573804573852, 1180.5513904716154, 1201.6755476021426, 32462.0, 33618.8319058408, 34329.82835085859, 36152.0, 36476.27047459036, 1102.6802227354137, 1141.8972292493715, 1151.9136064795173, 1153.1524329617723, 1179.9587014454453, 18034.458966231035, 18308.359207427675, 18462.907685461487, 19125.42623721263, 19289.131989060246, 585919.0, 586859.0, 591671.0, 591823.0, 592527.0, 61043.99999999911, 61249.38750612437, 61662.69168654128, 61778.0, 61790.69104654448, 1254.6737848159544, 1377.2838124175373, 1398.3427788939182, 1439.6688761584685, 1445.132920247864, 32894.34211315808, 34050.829745851115, 34094.147646309044, 34127.93106719076, 34214.14464638404, 51910.480895190565, 52799.0, 52911.470885290655, 52967.47032529779, 52981.0, 440450.0, 452711.0, 453386.0, 453838.0, 454651.0, 25374.365640859127, 26107.216783496526, 27656.170314890587, 28117.578236326062, 28820.0, 48178.27732584084, 48374.0, 48681.756591216814, 49909.0, 50027.24959125543, 40221.59778402178, 40774.59225407708, 41084.58915410927, 41631.0, 42151.7892410536, 41146.58853411428, 41271.7936410316, 41378.1724365517, 41472.0, 41579.584204157574, 40339.193216134925, 40669.1866162681, 41606.0, 41676.79161604172, 41834.37248441337, 32884.83557582197, 36595.451068233466, 36792.160391980826, 36874.63125368712, 36967.81516092402, 27823.721762782112, 28009.299767505974, 28155.71844281531, 28232.0, 28235.15294541167], "value": 20884.807631155087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.1104725415069, 401.4660501532961, 402.6255582308452, 404.2945060868784, 422.2315385997484, 12770.744585108316, 17960.281588736452, 19453.70819437708, 19527.511812204702, 20186.293479728174, 15545.689086218268, 17948.282068717268, 18767.43697689068, 18781.34265300715, 19452.416427507163, 5630.296212973379, 5831.970840145815, 5832.883342333151, 5834.387389324123, 5836.416358364172, 5565.220869078312, 5729.0, 5784.3058832940105, 5789.334226563957, 5851.180834683148, 5782.277215348082, 5816.0, 5828.766849326022, 5837.182794408786, 5839.299284085916, 5635.915461268084, 5702.144678298247, 5795.275590551181, 5795.652260864362, 5800.1299805029375, 5163.432022477525, 5188.610854185951, 5193.558547523465, 5200.765965531522, 5208.2968799212, 22162.77837221623, 22496.662550061763, 23111.7688823113, 23595.76404235953, 23615.527689446113, 2500.4499010217723, 2562.666853309058, 2691.4078902641386, 2865.398266364066, 3221.774475786696, 14672.19302938338, 14698.265086745727, 14731.705365892622, 14750.778738318933, 15037.924810375987, 1934.9903250483799, 2019.717239586459, 2028.9695654565194, 2036.3890832750265, 2061.938141855747, 54726.452735472536, 62275.688621557056, 85579.5721021391, 85930.57034714786, 86844.0, 10425.635102771366, 10564.841527377095, 10884.129269658566, 10912.23614347004, 11129.332240065622, 15430.074195548303, 15499.457518986781, 15536.456224032105, 15561.0, 15602.609934751723, 8287.50274983503, 8288.544130072903, 8357.164283571716, 8535.146485351539, 8538.712595650719, 7261.491695581259, 8215.835683286301, 8242.093369729326, 8363.498190108612, 8381.413301068867, 6130.448259656652, 6574.934250657432, 6614.437772789367, 6620.238672552622, 6761.323867613298, 1920.932767353136, 1963.2735887721635, 1967.478618166187, 1982.8413726901813, 1984.781674015857, 875.3216257400438, 982.6811164930234, 1031.9896801032044, 1083.1389045708681, 1109.1293334732197, 17978.730319045226, 18117.0, 18141.183646735928, 18215.63568728618, 19501.609967800847, 990.8216521026285, 1009.6112996496255, 1015.4668798880647, 1049.742813010802, 1069.823479125951, 10461.738456538647, 11232.0, 11253.493592788343, 11259.774804503864, 11337.093032557375, 489762.0, 495875.0, 500748.0, 500926.0, 500930.0, 97097.51451242699, 97578.512107439, 97805.0, 98326.5083674577, 99381.0, 1038.3043360948184, 1050.1074087025968, 1056.3239526702916, 1059.4596755654518, 1070.4433694478828, 17362.913185434496, 17601.735973960658, 17740.55648608795, 17757.46727598174, 18122.81877181264, 43327.35008974805, 43397.18343477822, 44996.77501612471, 45215.0, 45350.09299814051, 59947.40052599592, 60476.92131940567, 61666.383336166065, 61910.0, 62004.379956201665, 8535.445196062235, 8598.183172598594, 8743.781405464913, 8876.51179185151, 9032.683856065269, 9954.502274886372, 13613.251271180181, 13805.102668326526, 13899.930500347433, 13947.232902190477, 11747.706307342385, 11934.940325298665, 12002.699932501408, 12129.696757580778, 12499.250044997329, 11750.94124529372, 11866.821997670215, 12120.696982575506, 12237.449314780679, 12335.568255111028, 11161.497732602214, 11327.433628318717, 11442.0, 11844.09819594205, 12539.74920501603, 8199.672013119409, 8210.137935516685, 8275.62759675828, 8594.054653988182, 8597.785055373666, 10439.164866810484, 10569.101626361846, 10700.197485188797, 10897.455127243447, 11062.944685276521], "value": 9481.707152629824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.2377421095766, 1458.3947661720385, 1464.7583148780454, 1648.0, 1819.4359748477973, 8334.124916883724, 8706.172913573208, 8712.085231050743, 8957.686480973167, 8967.058458861824, 8608.784780380494, 8804.64781408743, 8814.823703525926, 8823.426477278988, 8825.382223244376, 2089.2061016813664, 2323.105604342332, 2377.41753270449, 2388.4028992751814, 2403.086827005744, 2436.3909022744315, 2444.4133407982044, 2450.0934654177977, 2452.3623857796924, 2456.852588844675, 2363.7990770784504, 2410.80713542917, 2412.457197130649, 2423.0792298926385, 2424.066734307287, 2051.9589608207903, 2313.791758741713, 2379.6073647848084, 2385.940351491209, 2387.3434805428474, 2264.9660255096187, 2291.6104262275453, 2304.37781798915, 2310.7920287174234, 2323.303009097281, 8846.071162527905, 8847.911520884772, 8865.423747456394, 8881.777955551099, 8892.510911899843, 4960.379952505937, 5073.949260507385, 5074.162763144077, 5079.923801142986, 5080.060188865072, 3190.1386625611185, 3363.798172109681, 3369.6124945631323, 3398.762086653935, 3409.4033544129925, 1180.15029178991, 1188.8276199951044, 1198.1732604502952, 1217.4278089298016, 1225.148521777365, 12221.694457638541, 12260.325682087481, 12282.447289871978, 12291.877081229162, 12303.75392492154, 4449.466064072268, 4550.704204226715, 4626.653001024936, 4628.5371462853445, 4678.204705200056, 10353.63762268317, 10357.689269321932, 10395.272330936914, 10397.792044159074, 10401.53193106312, 4731.69243999139, 5260.736963151827, 5315.149576067811, 5321.840344789663, 5323.22813192085, 4669.39297891272, 4824.0834241494, 4846.248831431134, 4885.193942999436, 4886.584640305543, 3944.6449819515806, 3952.8190294665474, 4068.2880495913096, 4144.336906095071, 4153.273177193979, 1295.8121072444442, 1302.9739405212033, 1312.3700623700677, 1320.610419926124, 1324.9801252981213, 948.9620415183315, 966.3863446711389, 971.5579411367811, 974.8927617962019, 985.9605615775289, 5616.0, 5628.71856407178, 5719.428057194247, 5849.532037436995, 5907.438793314628, 1012.2964539644876, 1019.154102095274, 1065.733566608348, 1089.6844206062117, 1091.825307950724, 4011.9799401003393, 4158.334666453414, 4162.895927601774, 4173.8956526087095, 4183.4979802423295, 10502.159827213805, 10759.462026898624, 10819.513121909533, 10842.457877106113, 10853.782924341469, 10607.363558186533, 10678.14574834027, 10685.519151638195, 10689.251752377415, 10691.037806597444, 7820.648070836713, 8107.837843243102, 8125.187481251827, 8310.626021829032, 8316.584170791557, 5791.942080579309, 6008.579399441997, 6086.482648974887, 6115.877682446415, 6201.255849297932, 9801.31390802637, 10025.498725063864, 10103.747406314607, 10217.795644086927, 10249.487525623837, 9792.951035244778, 10110.79778404413, 10370.740731481774, 10387.220958427997, 10388.11701005423, 6818.761343352959, 7573.6213189341415, 7603.20166382544, 7737.381009519338, 7799.805004874924, 8645.178708022728, 8681.739547813575, 8754.387192896691, 8764.474131552128, 8773.034966153846, 7572.659230334538, 7750.8837367440665, 7799.45403821727, 7869.370450364072, 7879.448438609243, 7632.542047477169, 7758.495697779626, 7761.068671759425, 7894.328982036591, 7901.0518737749535, 7173.964130179315, 7183.425325973805, 7248.637568121679, 7258.165310989304, 7258.600776957107, 4777.402824646919, 4908.950910490849, 4927.679700819435, 4939.678920870132, 5021.748912554431, 5017.84946451607, 5118.923216151835, 5179.637425380187, 5198.844034678966, 5305.946940530545], "value": 4668.548707098706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.86216495824317, 320.2889585121032, 327.1738859380065, 331.5457822782788, 332.2673504921648, 5338.932213557285, 5340.62615616907, 5376.623636345453, 5416.4312747161575, 5421.620486565932, 5234.450382709818, 5239.842804715865, 5256.290400795891, 5279.313689220396, 5290.724988255049, 3899.278633452806, 4018.8995275118064, 4028.4561584186054, 4038.6163314485075, 4073.368627862686, 4085.632293093621, 4089.9386509202386, 4095.2219078375015, 4097.7541347519245, 4101.0, 3970.7617542947373, 4048.8785336439955, 4052.642364807793, 4052.8581499647516, 4080.2655522006025, 3995.720299579031, 4060.309747342959, 4080.9591904080876, 4094.2425651254466, 4098.262312783698, 3560.2523470071055, 3565.8217089145437, 3571.6964058055096, 3571.94642080369, 3582.6775590197008, 5085.169339037943, 5099.674084737958, 5112.897742045176, 5132.178851383761, 5155.0978578748945, 4487.730736155841, 4631.143238500888, 4648.163330600491, 4700.694454860457, 4709.387779588666, 5476.26070480484, 5519.39286678465, 5538.452311936514, 5552.805651802168, 5564.8330550083565, 3942.1524372259814, 3942.5071866016747, 3945.948106984352, 3952.249072676211, 3954.8615798446917, 5531.695756733378, 5749.59752817303, 5765.6540607563265, 5781.306243250837, 5799.21710569072, 3982.761034337949, 3994.6205110514456, 4017.5580686124504, 4019.437278780973, 4025.355943049098, 4075.918481630351, 4078.1028173801715, 4082.1835632873544, 4097.795110244476, 4106.1582375612925, 4671.556202160789, 4683.81264749413, 4694.81220751173, 4713.905721885543, 4716.575508204278, 5321.201819727072, 5533.253010843485, 5551.639143455663, 5565.805196818092, 5592.972035139798, 1377.1805775563723, 1397.7623803953352, 1399.237415608496, 1403.6350548857167, 1408.204364534035, 898.4564338575068, 902.8871391076116, 905.9365844390961, 909.8316811389914, 941.8540126280437, 5313.635432232697, 5333.466653334713, 5358.91961620576, 5374.6506477078865, 5401.810936617199, 5707.857303567444, 5733.741981610838, 5745.741441635137, 5747.109198074305, 5750.1949727038245, 5112.565431938327, 5284.5772338212855, 5295.602829787781, 5325.0, 5352.197170424468, 2989.7159769821833, 3006.9248268793453, 3024.6672865984724, 3047.5581040748966, 3065.693430656961, 5816.534677225896, 5829.854253643693, 5850.385709500526, 5866.560007999417, 5878.677297608004, 5604.747786349624, 5905.320888097838, 5907.734151963086, 5916.467517923407, 5953.374895635982, 5949.553783466257, 5959.523238140939, 5973.671448070311, 5986.8026394720355, 5987.6108052976415, 5568.498835104698, 5752.928945579504, 5779.537636989115, 5787.8553036174435, 5790.623609465371, 5677.716114194356, 5710.314762228559, 5735.397783232867, 5738.302997591126, 5741.167530708108, 5846.56150788684, 5868.794592189253, 5981.850453738692, 6005.6396616203165, 6034.849128771816, 4125.525564560114, 4135.214309281227, 4146.419501269765, 4148.8133034014145, 4159.958400415957, 5786.218860453785, 5808.912866306924, 5820.854478638068, 5862.824115276549, 5879.794207202727, 5621.7189140542, 5683.261176047087, 5722.914156287576, 5752.7698892043845, 5764.337101233412, 5626.831195064155, 5640.915386269291, 5661.716914154358, 5675.4040825714355, 5676.886462270649, 5290.523852853262, 5297.0, 5533.889322213453, 5541.695206763667, 5609.775608975759, 5606.24315717373, 5669.659820410624, 5675.233843431084, 5677.091665333527, 5706.572007099401, 5523.906612297126, 5542.7782888684005, 5551.528120109836, 5585.497305242548, 5589.323203038991], "value": 4236.849836427101, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6096829648583, 778.8559116563437, 812.1513018895254, 840.4579046514995, 852.9147085291472, 13729.931350343248, 15140.0, 15475.84524154758, 15490.535283941472, 15505.534833954971, 14576.708465830678, 15267.465638702648, 15306.617334566641, 15711.057336559814, 15727.685446291067, 668.5787953589232, 793.5119901260712, 815.4210510537511, 816.0493025625169, 821.7000794709918, 807.2653884964683, 819.6229734322189, 820.0569345252977, 820.5281962871343, 820.9384296177781, 855.3969451536652, 859.5530324231396, 860.2172023458654, 860.384824850232, 860.9139086091403, 702.6978399288304, 812.5368539932241, 834.1033389106674, 846.5301757524571, 847.1655419411875, 615.0681717198448, 615.5352708704944, 616.2450997528038, 616.312811215496, 616.4698359410903, 14593.0, 14653.926730366387, 14661.120332779961, 14677.633059173499, 14691.338889749986, 13949.860501394958, 14184.219867907364, 14206.715865682629, 14435.927820360936, 14554.0, 13158.342082895817, 13349.66625834362, 13359.465621375133, 13494.0, 13658.726825463535, 4486.820527178909, 4526.117407105616, 4562.498125206224, 4627.0, 4646.070785842811, 79770.0, 81557.59221203915, 81563.59218203872, 81672.0, 81879.5906020472, 10429.739256518647, 10434.634787782392, 10565.735856603646, 11285.717857053474, 11481.655550333504, 19804.801951980295, 20095.698564521543, 20140.597188056156, 20169.697454538193, 20329.085191166432, 8549.529775862387, 8595.613197406132, 8607.61265743043, 8787.165219304155, 8804.823903521894, 4604.907901841944, 4712.9080818971115, 4722.693024953367, 4722.811087556528, 4821.9035619287415, 3405.4891766235264, 3503.684668379858, 3517.8944631661093, 3518.0, 3520.2079532105586, 624.7938180400457, 633.4425705379236, 636.0618088319692, 643.6106155775782, 645.7965740791635, 565.3300838506383, 621.3631028196045, 697.9895301570481, 706.6713978000255, 780.9687612495436, 9929.80140397188, 10629.4153821539, 10669.413182274895, 10731.624393146203, 10741.51663175159, 601.6119602856133, 668.4785867023729, 692.6052150274295, 703.0719450325623, 775.1707751707708, 4715.0, 4773.212419950669, 4860.198067318924, 4864.318995340655, 4960.528749768766, 101141.0, 107206.46396768122, 110640.0, 111645.0, 113814.0, 80506.19493804987, 92511.53744231236, 94269.0, 94516.0, 95181.0, 56653.43346566481, 63409.68295158587, 86798.0, 89379.0, 90531.54734226418, 10300.124489418484, 10562.78874422492, 10607.151427885905, 10609.787804243717, 10721.195910306602, 44833.87915302144, 53659.73170134125, 53779.0, 55503.0, 55981.0, 51277.7436112817, 52171.0, 59310.0, 68596.65701671659, 75420.62289688736, 12793.872061279268, 13003.544875929298, 13451.058425910092, 13517.391717372939, 13700.24648644334, 14929.552113436614, 14981.052463179716, 15451.922740386226, 15516.456924007605, 15667.451639192574, 14547.78178327347, 14567.635809104857, 14601.780973285197, 14903.85096149068, 15268.77096843526, 13569.93215033958, 13587.252701101534, 14041.36813843359, 14367.640808979859, 14368.425262989364, 12439.502419903465, 12982.221066736027, 13090.934545327213, 13193.076484645982, 13520.526781562598, 11314.626272659549, 11636.476358564054, 11832.76334473323, 11961.700957476132, 12041.879581204426, 10846.857949293846, 12102.24930593833, 12164.148509604243, 12317.137800353888, 12460.376981150725], "value": 7599.839686334659, "unit": "score"}], "name": "dromaeo_css", "value": 7359.473872463589, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 109.0, 110.0, 110.0, 109.0, 109.0, 108.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 126.0, 183.0, 128.0, 128.0, 152.0, 133.0, 159.0, 124.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 121.0, 75.0, 75.0, 74.0, 73.0, 104.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 85.0, 85.0, 118.0, 85.0, 85.0, 122.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 177.0, 146.0, 146.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 55.0, 60.0, 56.0, 54.0, 53.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 86.0, 83.0, 87.0, 80.0, 119.0, 79.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 119.0, 135.0, 125.0, 120.0, 117.0, 124.0, 143.0, 124.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 161.0, 165.0, 162.0, 164.0, 164.0, 163.0, 164.0, 160.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 63.0, 65.0, 63.0, 63.0, 62.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1503.4, "alertThreshold": 2.0}]} 10:36:12 INFO - Return code: 0 10:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:12 ERROR - # TBPL SUCCESS # 10:36:12 INFO - Running post-action listener: _resource_record_post_action 10:36:12 INFO - ##### 10:36:12 INFO - ##### Finished run-tests step (success) 10:36:12 INFO - ##### 10:36:12 INFO - Running post-run listener: _resource_record_post_run 10:36:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 541376512; Read time: 0; Write time: 535832 10:36:12 INFO - TinderboxPrint: CPU usage
13.1% 10:36:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:36:12 INFO - TinderboxPrint: I/O write bytes / time
541,376,512 / 535,832 10:36:12 INFO - TinderboxPrint: CPU idle
8,270.1 (86.8%) 10:36:12 INFO - TinderboxPrint: CPU user
1,206.8 (12.7%) 10:36:12 INFO - TinderboxPrint: Swap in / out
0 / 0 10:36:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246661120; Read time: 0; Write time: 302788 10:36:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 292904960; Read time: 0; Write time: 232460 10:36:13 INFO - Running post-run listener: _upload_blobber_files 10:36:13 INFO - Blob upload gear active. 10:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:13 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 10:36:13 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:36:13 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:14 INFO - (blobuploader) - INFO - Done attempting. 10:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:15 INFO - (blobuploader) - INFO - Done attempting. 10:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:18 INFO - (blobuploader) - INFO - Done attempting. 10:36:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:18 INFO - Return code: 0 10:36:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/258c299018f86858fd7a320fd8874e5e2be76f067f8a8349c6e1e2421383e10fe94f3b5438936cc210d80abd9c5ca5e2e104df593299c1a2fedf88bf7e29620e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa76e2220cd5378e14c8f6c296d0b78036479561088c9c88f6c8b028f704ce35f73df3722bc6719b2a0262a3ed9977497c5a4cbb03712b48b2079b146c508d46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00db11c49298254435aeaeb29ce337ca54482d940adb49f70d07e896a375e655078228b26f8f36a9ce03457afd1e6da9b36959372e46fb31b1c07f74ffb40e6f"} 10:36:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:18 INFO - Contents: 10:36:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/258c299018f86858fd7a320fd8874e5e2be76f067f8a8349c6e1e2421383e10fe94f3b5438936cc210d80abd9c5ca5e2e104df593299c1a2fedf88bf7e29620e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa76e2220cd5378e14c8f6c296d0b78036479561088c9c88f6c8b028f704ce35f73df3722bc6719b2a0262a3ed9977497c5a4cbb03712b48b2079b146c508d46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00db11c49298254435aeaeb29ce337ca54482d940adb49f70d07e896a375e655078228b26f8f36a9ce03457afd1e6da9b36959372e46fb31b1c07f74ffb40e6f"} 10:36:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:18 INFO - Copying logs to upload dir... 10:36:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.036846 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-03 10:36:18.678574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 10:36:18.682321) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/258c299018f86858fd7a320fd8874e5e2be76f067f8a8349c6e1e2421383e10fe94f3b5438936cc210d80abd9c5ca5e2e104df593299c1a2fedf88bf7e29620e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa76e2220cd5378e14c8f6c296d0b78036479561088c9c88f6c8b028f704ce35f73df3722bc6719b2a0262a3ed9977497c5a4cbb03712b48b2079b146c508d46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00db11c49298254435aeaeb29ce337ca54482d940adb49f70d07e896a375e655078228b26f8f36a9ce03457afd1e6da9b36959372e46fb31b1c07f74ffb40e6f"} build_url:https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/XZetlS7vRDOfvtaq1KnP9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/258c299018f86858fd7a320fd8874e5e2be76f067f8a8349c6e1e2421383e10fe94f3b5438936cc210d80abd9c5ca5e2e104df593299c1a2fedf88bf7e29620e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa76e2220cd5378e14c8f6c296d0b78036479561088c9c88f6c8b028f704ce35f73df3722bc6719b2a0262a3ed9977497c5a4cbb03712b48b2079b146c508d46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00db11c49298254435aeaeb29ce337ca54482d940adb49f70d07e896a375e655078228b26f8f36a9ce03457afd1e6da9b36959372e46fb31b1c07f74ffb40e6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 10:36:18.711462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:36:18.711788) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464973831.718391-1397979268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 10:36:18.762937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 10:36:18.763250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 10:36:18.763552) ========= ========= Total master_lag: 0.15 =========