builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1466764225.44 results: success (0) buildid: 20160624021358 builduid: bd0a5a4b9424469e990508583acf8ef3 revision: 34e0a985d93d88be6058db05071121decf373c97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.443742) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.444173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.444456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.459323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.459658) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 03:30:25-- 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% 214M=0s 2016-06-24 03:30:25 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.576364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.576932) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:25.627803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 03:30:25.628154) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e0a985d93d88be6058db05071121decf373c97 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34e0a985d93d88be6058db05071121decf373c97 --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=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 03:30:25,765 truncating revision to first 12 chars 2016-06-24 03:30:25,765 Setting DEBUG logging. 2016-06-24 03:30:25,765 attempt 1/10 2016-06-24 03:30:25,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e0a985d93d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 03:30:26,437 unpacking tar archive at: mozilla-central-34e0a985d93d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.020604 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 03:30:26.663063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:26.663537) ========= script_repo_revision: 34e0a985d93d88be6058db05071121decf373c97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:26.664199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:26.664649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:26.675652) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 03:30:26.675948) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:26 INFO - MultiFileLogger online at 20160624 03:30:26 in /builds/slave/test 03:30:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:30:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:26 INFO - {'append_to_log': False, 03:30:26 INFO - 'base_work_dir': '/builds/slave/test', 03:30:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:30:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:26 INFO - 'branch': 'Firefox-Non-PGO', 03:30:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:26 INFO - 'config_files': ('talos/linux_config.py',), 03:30:26 INFO - 'default_actions': ('clobber', 03:30:26 INFO - 'read-buildbot-config', 03:30:26 INFO - 'download-and-extract', 03:30:26 INFO - 'populate-webroot', 03:30:26 INFO - 'create-virtualenv', 03:30:26 INFO - 'install', 03:30:26 INFO - 'run-tests'), 03:30:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:26 INFO - 'download_minidump_stackwalk': True, 03:30:26 INFO - 'download_symbols': 'ondemand', 03:30:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:26 INFO - 'installer_path': 'installer.exe', 03:30:26 INFO - 'log_level': 'info', 03:30:26 INFO - 'log_name': 'talos', 03:30:26 INFO - 'log_to_console': True, 03:30:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:26 INFO - 'opt_config_files': (), 03:30:26 INFO - 'pip_index': False, 03:30:26 INFO - 'sps_profile': False, 03:30:26 INFO - 'sps_profile_interval': 0, 03:30:26 INFO - 'suite': 'dromaeojs-e10s', 03:30:26 INFO - 'system_bits': '32', 03:30:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:26 INFO - 'title': 'talos-linux64-ix-040', 03:30:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:26 INFO - 'use_talos_json': True, 03:30:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:26 INFO - 'work_dir': 'build'} 03:30:26 INFO - ##### 03:30:26 INFO - ##### Running clobber step. 03:30:26 INFO - ##### 03:30:26 INFO - Running pre-action listener: _resource_record_pre_action 03:30:26 INFO - Running main action method: clobber 03:30:26 INFO - rmtree: /builds/slave/test/build 03:30:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:27 INFO - Running post-action listener: _resource_record_post_action 03:30:27 INFO - ##### 03:30:27 INFO - ##### Finished clobber step (success) 03:30:27 INFO - ##### 03:30:27 INFO - ##### 03:30:27 INFO - ##### Running read-buildbot-config step. 03:30:27 INFO - ##### 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: read_buildbot_config 03:30:27 INFO - Using buildbot properties: 03:30:27 INFO - { 03:30:27 INFO - "project": "", 03:30:27 INFO - "product": "firefox", 03:30:27 INFO - "script_repo_revision": "production", 03:30:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:30:27 INFO - "repository": "", 03:30:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:30:27 INFO - "buildid": "20160624021358", 03:30:27 INFO - "pgo_build": "False", 03:30:27 INFO - "basedir": "/builds/slave/test", 03:30:27 INFO - "buildnumber": 360, 03:30:27 INFO - "slavename": "talos-linux64-ix-040", 03:30:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:27 INFO - "platform": "ubuntu64_hw", 03:30:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:30:27 INFO - "branch": "mozilla-central", 03:30:27 INFO - "repo_path": "mozilla-central", 03:30:27 INFO - "revision": "34e0a985d93d88be6058db05071121decf373c97", 03:30:27 INFO - "stage_platform": "linux64", 03:30:27 INFO - "builduid": "bd0a5a4b9424469e990508583acf8ef3", 03:30:27 INFO - "slavebuilddir": "test" 03:30:27 INFO - } 03:30:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:30:27 INFO - Running post-action listener: _resource_record_post_action 03:30:27 INFO - ##### 03:30:27 INFO - ##### Finished read-buildbot-config step (success) 03:30:27 INFO - ##### 03:30:27 INFO - ##### 03:30:27 INFO - ##### Running download-and-extract step. 03:30:27 INFO - ##### 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: download_and_extract 03:30:27 INFO - mkdir: /builds/slave/test/build/tests 03:30:27 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')]} 03:30:27 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:28 INFO - Downloaded 1361 bytes. 03:30:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:28 INFO - Using the following test package requirements: 03:30:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'jsshell-linux-x86_64.zip'], 03:30:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:28 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:29 INFO - Downloaded 22709610 bytes. 03:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:31 INFO - Return code: 0 03:30:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:31 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:32 INFO - Downloaded 22709610 bytes. 03:30:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:33 INFO - Return code: 0 03:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:33 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:35 INFO - Downloaded 14405384 bytes. 03:30:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:30:35 INFO - Return code: 0 03:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:35 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:30:37 INFO - Downloaded 56252982 bytes. 03:30:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:37 INFO - mkdir: /builds/slave/test/properties 03:30:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:37 INFO - Contents: 03:30:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - Running post-action listener: _resource_record_post_action 03:30:38 INFO - Running post-action listener: set_extra_try_arguments 03:30:38 INFO - ##### 03:30:38 INFO - ##### Finished download-and-extract step (success) 03:30:38 INFO - ##### 03:30:38 INFO - ##### 03:30:38 INFO - ##### Running populate-webroot step. 03:30:38 INFO - ##### 03:30:38 INFO - Running pre-action listener: _resource_record_pre_action 03:30:38 INFO - Running main action method: populate_webroot 03:30:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:38 INFO - '--tppagecycles', 03:30:38 INFO - '7'], 03:30:38 INFO - 'tests': ['tsvgm']}}, 03:30:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['damp', 'tps']}, 03:30:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'tests': ['damp', 'tps']}, 03:30:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['dromaeo_dom']}, 03:30:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['basic_compositor_video']}, 03:30:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['a11yr', 03:30:38 INFO - 'ts_paint', 03:30:38 INFO - 'tpaint', 03:30:38 INFO - 'sessionrestore', 03:30:38 INFO - 'sessionrestore_no_auto_restore', 03:30:38 INFO - 'tabpaint']}, 03:30:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['tsvgx', 03:30:38 INFO - 'tsvgr_opacity', 03:30:38 INFO - 'tart', 03:30:38 INFO - 'tscrollx', 03:30:38 INFO - 'cart']}, 03:30:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:38 INFO - 'tsvgr_opacity', 03:30:38 INFO - 'tart', 03:30:38 INFO - 'tscrollx', 03:30:38 INFO - 'cart']}, 03:30:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'talos_options': ['--disable-e10s'], 03:30:38 INFO - 'tests': ['tp5o']}, 03:30:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'tests': ['tp5o']}, 03:30:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'talos_options': ['--disable-e10s', 03:30:38 INFO - '--xperf_path', 03:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:38 INFO - 'tests': ['tp5n']}, 03:30:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:38 INFO - 'talos_options': ['--xperf_path', 03:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:38 INFO - 'tests': ['tp5n']}}, 03:30:38 INFO - 'talos.zip': {'path': '', 03:30:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:38 INFO - Running post-action listener: _resource_record_post_action 03:30:38 INFO - ##### 03:30:38 INFO - ##### Finished populate-webroot step (success) 03:30:38 INFO - ##### 03:30:38 INFO - ##### 03:30:38 INFO - ##### Running create-virtualenv step. 03:30:38 INFO - ##### 03:30:38 INFO - Running pre-action listener: _resource_record_pre_action 03:30:38 INFO - Running main action method: create_virtualenv 03:30:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:38 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 03:30:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:38 INFO - Using real prefix '/usr' 03:30:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:40 INFO - Installing pip.................done. 03:30:40 INFO - Return code: 0 03:30:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:40 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 03:30:40 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 03:30:40 INFO - Using env: {'DISPLAY': ':0', 03:30:40 INFO - 'HOME': '/home/cltbld', 03:30:40 INFO - 'LANG': 'en_US.UTF-8', 03:30:40 INFO - 'LANGUAGE': 'en_US:en', 03:30:40 INFO - 'LOGNAME': 'cltbld', 03:30:40 INFO - 'MAIL': '/var/mail/cltbld', 03:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:40 INFO - 'MOZ_NO_REMOTE': '1', 03:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:40 INFO - 'NO_EM_RESTART': '1', 03:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:40 INFO - 'PWD': '/builds/slave/test', 03:30:40 INFO - 'SHELL': '/bin/bash', 03:30:40 INFO - 'SHLVL': '1', 03:30:40 INFO - 'TERM': 'linux', 03:30:40 INFO - 'TMOUT': '86400', 03:30:40 INFO - 'USER': 'cltbld', 03:30:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:40 INFO - '_': '/tools/buildbot/bin/python'} 03:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:41 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 03:30:41 INFO - Cleaning up... 03:30:41 INFO - Return code: 0 03:30:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:41 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:41 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 03:30:41 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 03:30:41 INFO - Using env: {'DISPLAY': ':0', 03:30:41 INFO - 'HOME': '/home/cltbld', 03:30:41 INFO - 'LANG': 'en_US.UTF-8', 03:30:41 INFO - 'LANGUAGE': 'en_US:en', 03:30:41 INFO - 'LOGNAME': 'cltbld', 03:30:41 INFO - 'MAIL': '/var/mail/cltbld', 03:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:41 INFO - 'MOZ_NO_REMOTE': '1', 03:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:41 INFO - 'NO_EM_RESTART': '1', 03:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:41 INFO - 'PWD': '/builds/slave/test', 03:30:41 INFO - 'SHELL': '/bin/bash', 03:30:41 INFO - 'SHLVL': '1', 03:30:41 INFO - 'TERM': 'linux', 03:30:41 INFO - 'TMOUT': '86400', 03:30:41 INFO - 'USER': 'cltbld', 03:30:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:41 INFO - '_': '/tools/buildbot/bin/python'} 03:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:41 INFO - Downloading/unpacking psutil>=3.1.1 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:43 INFO - Installing collected packages: psutil 03:30:43 INFO - Running setup.py install for psutil 03:30:43 INFO - building 'psutil._psutil_linux' extension 03:30:43 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 03:30:43 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 03:30:43 INFO - building 'psutil._psutil_posix' extension 03:30:43 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 03:30:43 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 03:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:43 INFO - Successfully installed psutil 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:43 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 03:30:43 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 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:45 INFO - Installing collected packages: mozsystemmonitor 03:30:45 INFO - Running setup.py install for mozsystemmonitor 03:30:46 INFO - Successfully installed mozsystemmonitor 03:30:46 INFO - Cleaning up... 03:30:46 INFO - Return code: 0 03:30:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:46 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')]} 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:46 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')]} 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:46 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:46 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 03:30:46 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 03:30:46 INFO - Using env: {'DISPLAY': ':0', 03:30:46 INFO - 'HOME': '/home/cltbld', 03:30:46 INFO - 'LANG': 'en_US.UTF-8', 03:30:46 INFO - 'LANGUAGE': 'en_US:en', 03:30:46 INFO - 'LOGNAME': 'cltbld', 03:30:46 INFO - 'MAIL': '/var/mail/cltbld', 03:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:46 INFO - 'MOZ_NO_REMOTE': '1', 03:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:46 INFO - 'NO_EM_RESTART': '1', 03:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:46 INFO - 'PWD': '/builds/slave/test', 03:30:46 INFO - 'SHELL': '/bin/bash', 03:30:46 INFO - 'SHLVL': '1', 03:30:46 INFO - 'TERM': 'linux', 03:30:46 INFO - 'TMOUT': '86400', 03:30:46 INFO - 'USER': 'cltbld', 03:30:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:46 INFO - '_': '/tools/buildbot/bin/python'} 03:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:46 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 03:30:46 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 03:30:46 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 03:30:46 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 03:30:46 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 03:30:46 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 03:30:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:48 INFO - warning: no files found matching '*.txt' 03:30:48 INFO - no previously-included directories found matching 'build' 03:30:48 INFO - no previously-included directories found matching 'dist' 03:30:48 INFO - no previously-included directories found matching '.git*' 03:30:48 INFO - Installing collected packages: jsonschema, functools32 03:30:48 INFO - Running setup.py install for functools32 03:30:48 INFO - warning: no files found matching '*.txt' 03:30:48 INFO - no previously-included directories found matching 'build' 03:30:48 INFO - no previously-included directories found matching 'dist' 03:30:48 INFO - no previously-included directories found matching '.git*' 03:30:48 INFO - Successfully installed jsonschema functools32 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:30:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 INFO - Downloading docopt-0.6.1.tar.gz 03:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:51 INFO - Running setup.py install for blobuploader 03:30:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:51 INFO - Running setup.py install for requests 03:30:52 INFO - Running setup.py install for docopt 03:30:52 INFO - Successfully installed blobuploader requests docopt 03:30:52 INFO - Cleaning up... 03:30:52 INFO - Return code: 0 03:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:52 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:52 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 03:30:52 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 03:30:52 INFO - Using env: {'DISPLAY': ':0', 03:30:52 INFO - 'HOME': '/home/cltbld', 03:30:52 INFO - 'LANG': 'en_US.UTF-8', 03:30:52 INFO - 'LANGUAGE': 'en_US:en', 03:30:52 INFO - 'LOGNAME': 'cltbld', 03:30:52 INFO - 'MAIL': '/var/mail/cltbld', 03:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:52 INFO - 'MOZ_NO_REMOTE': '1', 03:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:52 INFO - 'NO_EM_RESTART': '1', 03:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:52 INFO - 'PWD': '/builds/slave/test', 03:30:52 INFO - 'SHELL': '/bin/bash', 03:30:52 INFO - 'SHLVL': '1', 03:30:52 INFO - 'TERM': 'linux', 03:30:52 INFO - 'TMOUT': '86400', 03:30:52 INFO - 'USER': 'cltbld', 03:30:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:52 INFO - '_': '/tools/buildbot/bin/python'} 03:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:52 INFO - Running setup.py (path:/tmp/pip-fzbyhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:52 INFO - Running setup.py (path:/tmp/pip-No82jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:52 INFO - Running setup.py (path:/tmp/pip-6N3HYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:52 INFO - Running setup.py (path:/tmp/pip-dnmIU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:52 INFO - Running setup.py (path:/tmp/pip-1v_CjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:52 INFO - Running setup.py (path:/tmp/pip-IrS77Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:52 INFO - Running setup.py (path:/tmp/pip-uLfZOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:52 INFO - Running setup.py (path:/tmp/pip-hVjdU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:52 INFO - Running setup.py (path:/tmp/pip-5Qsuhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:53 INFO - Running setup.py (path:/tmp/pip-GGvURi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:53 INFO - Running setup.py (path:/tmp/pip-Jhx2kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:53 INFO - Running setup.py (path:/tmp/pip-XbsZpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:53 INFO - Running setup.py (path:/tmp/pip-FOAzip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:53 INFO - Running setup.py (path:/tmp/pip-tENvJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:53 INFO - Running setup.py (path:/tmp/pip-Xp3tf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:53 INFO - Running setup.py (path:/tmp/pip-4rO9CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:53 INFO - Running setup.py (path:/tmp/pip-YMM4Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:53 INFO - Running setup.py install for manifestparser 03:30:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:53 INFO - Running setup.py install for mozcrash 03:30:53 INFO - Running setup.py install for mozdebug 03:30:53 INFO - Running setup.py install for mozdevice 03:30:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozfile 03:30:54 INFO - Running setup.py install for mozhttpd 03:30:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozinfo 03:30:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozInstall 03:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozleak 03:30:54 INFO - Running setup.py install for mozlog 03:30:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for moznetwork 03:30:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozprocess 03:30:54 INFO - Running setup.py install for mozprofile 03:30:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:54 INFO - Running setup.py install for mozrunner 03:30:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:55 INFO - Running setup.py install for mozscreenshot 03:30:55 INFO - Running setup.py install for moztest 03:30:55 INFO - Running setup.py install for mozversion 03:30:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 INFO - Running setup.py (path:/tmp/pip-Sk0H9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 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)) 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 INFO - Running setup.py (path:/tmp/pip-gIXVnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 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)) 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 INFO - Running setup.py (path:/tmp/pip-02C8_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 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)) 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:55 INFO - Running setup.py (path:/tmp/pip-mjXdAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:55 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)) 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:55 INFO - Running setup.py (path:/tmp/pip-SEeEt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:55 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)) 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:55 INFO - Running setup.py (path:/tmp/pip-pRv1jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:56 INFO - Running setup.py (path:/tmp/pip-QQzkLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:56 INFO - Running setup.py (path:/tmp/pip-8bTODG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:56 INFO - Running setup.py (path:/tmp/pip-3UdCYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:56 INFO - Running setup.py (path:/tmp/pip-DG7bBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:56 INFO - Running setup.py (path:/tmp/pip-nAIb4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 INFO - Running setup.py (path:/tmp/pip-OdU16M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 INFO - Running setup.py (path:/tmp/pip-1mkRbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 INFO - Running setup.py (path:/tmp/pip-hfn1oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 INFO - Running setup.py (path:/tmp/pip-Mul7nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:56 INFO - Running setup.py (path:/tmp/pip-x2qLsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:56 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)) 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:56 INFO - Running setup.py (path:/tmp/pip-gvV9vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:56 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)) 03:30:56 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)) 03:30:56 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)) 03:30:56 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)) 03:30:56 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)) 03:30:56 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)) 03:30:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:58 INFO - Downloading blessings-1.6.tar.gz 03:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:58 INFO - Installing collected packages: blessings 03:30:58 INFO - Running setup.py install for blessings 03:30:58 INFO - Successfully installed blessings 03:30:58 INFO - Cleaning up... 03:30:59 INFO - Return code: 0 03:30:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:59 INFO - Reading from file tmpfile_stdout 03:30:59 INFO - Current package versions: 03:30:59 INFO - argparse == 1.2.1 03:30:59 INFO - blessings == 1.6 03:30:59 INFO - blobuploader == 1.2.4 03:30:59 INFO - docopt == 0.6.1 03:30:59 INFO - functools32 == 3.2.3-2 03:30:59 INFO - jsonschema == 2.5.1 03:30:59 INFO - manifestparser == 1.1 03:30:59 INFO - mozInstall == 1.12 03:30:59 INFO - mozcrash == 0.17 03:30:59 INFO - mozdebug == 0.1 03:30:59 INFO - mozdevice == 0.48 03:30:59 INFO - mozfile == 1.2 03:30:59 INFO - mozhttpd == 0.7 03:30:59 INFO - mozinfo == 0.9 03:30:59 INFO - mozleak == 0.1 03:30:59 INFO - mozlog == 3.2 03:30:59 INFO - moznetwork == 0.27 03:30:59 INFO - mozprocess == 0.22 03:30:59 INFO - mozprofile == 0.28 03:30:59 INFO - mozrunner == 6.11 03:30:59 INFO - mozscreenshot == 0.1 03:30:59 INFO - mozsystemmonitor == 0.3 03:30:59 INFO - moztest == 0.7 03:30:59 INFO - mozversion == 1.4 03:30:59 INFO - psutil == 3.1.1 03:30:59 INFO - requests == 1.2.3 03:30:59 INFO - wsgiref == 0.1.2 03:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:59 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 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30:59 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 03:30:59 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 03:30:59 INFO - Using env: {'DISPLAY': ':0', 03:30:59 INFO - 'HOME': '/home/cltbld', 03:30:59 INFO - 'LANG': 'en_US.UTF-8', 03:30:59 INFO - 'LANGUAGE': 'en_US:en', 03:30:59 INFO - 'LOGNAME': 'cltbld', 03:30:59 INFO - 'MAIL': '/var/mail/cltbld', 03:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:59 INFO - 'MOZ_NO_REMOTE': '1', 03:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:59 INFO - 'NO_EM_RESTART': '1', 03:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:59 INFO - 'PWD': '/builds/slave/test', 03:30:59 INFO - 'SHELL': '/bin/bash', 03:30:59 INFO - 'SHLVL': '1', 03:30:59 INFO - 'TERM': 'linux', 03:30:59 INFO - 'TMOUT': '86400', 03:30:59 INFO - 'USER': 'cltbld', 03:30:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:59 INFO - '_': '/tools/buildbot/bin/python'} 03:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 INFO - Cleaning up... 03:30:59 INFO - Return code: 0 03:30:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30: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', 'jsonschema'] in /builds/slave/test/build 03:30: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 jsonschema 03:30:59 INFO - Using env: {'DISPLAY': ':0', 03:30:59 INFO - 'HOME': '/home/cltbld', 03:30:59 INFO - 'LANG': 'en_US.UTF-8', 03:30:59 INFO - 'LANGUAGE': 'en_US:en', 03:30:59 INFO - 'LOGNAME': 'cltbld', 03:30:59 INFO - 'MAIL': '/var/mail/cltbld', 03:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:59 INFO - 'MOZ_NO_REMOTE': '1', 03:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:59 INFO - 'NO_EM_RESTART': '1', 03:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:59 INFO - 'PWD': '/builds/slave/test', 03:30:59 INFO - 'SHELL': '/bin/bash', 03:30:59 INFO - 'SHLVL': '1', 03:30:59 INFO - 'TERM': 'linux', 03:30:59 INFO - 'TMOUT': '86400', 03:30:59 INFO - 'USER': 'cltbld', 03:30:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:59 INFO - '_': '/tools/buildbot/bin/python'} 03:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:59 INFO - Cleaning up... 03:30:59 INFO - Return code: 0 03:30:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8e24daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', '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 03:30: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', 'flake8'] in /builds/slave/test/build 03:30: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 flake8 03:30:59 INFO - Using env: {'DISPLAY': ':0', 03:30:59 INFO - 'HOME': '/home/cltbld', 03:30:59 INFO - 'LANG': 'en_US.UTF-8', 03:30:59 INFO - 'LANGUAGE': 'en_US:en', 03:30:59 INFO - 'LOGNAME': 'cltbld', 03:30:59 INFO - 'MAIL': '/var/mail/cltbld', 03:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:59 INFO - 'MOZ_NO_REMOTE': '1', 03:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:59 INFO - 'NO_EM_RESTART': '1', 03:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:59 INFO - 'PWD': '/builds/slave/test', 03:30:59 INFO - 'SHELL': '/bin/bash', 03:30:59 INFO - 'SHLVL': '1', 03:30:59 INFO - 'TERM': 'linux', 03:30:59 INFO - 'TMOUT': '86400', 03:30:59 INFO - 'USER': 'cltbld', 03:30:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:59 INFO - '_': '/tools/buildbot/bin/python'} 03:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:59 INFO - Downloading/unpacking flake8 03:30:59 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 03:30:59 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 03:30:59 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 03:30:59 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 03:30:59 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 03:30:59 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 03:31:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:02 INFO - no previously-included directories found matching 'docs/_build' 03:31:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:02 INFO - Running setup.py install for pep8 03:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:02 INFO - no previously-included directories found matching 'docs/_build' 03:31:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:02 INFO - Cleaning up... 03:31:02 INFO - Return code: 0 03:31:02 INFO - Running post-action listener: _resource_record_post_action 03:31:02 INFO - Running post-action listener: _start_resource_monitoring 03:31:02 INFO - Starting resource monitoring. 03:31:02 INFO - ##### 03:31:02 INFO - ##### Finished create-virtualenv step (success) 03:31:02 INFO - ##### 03:31:02 INFO - ##### 03:31:02 INFO - ##### Running install step. 03:31:02 INFO - ##### 03:31:02 INFO - Running pre-action listener: _resource_record_pre_action 03:31:02 INFO - Running main action method: install 03:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:02 INFO - Reading from file tmpfile_stdout 03:31:02 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:03 INFO - Reading from file tmpfile_stdout 03:31:03 INFO - Output received: 03:31:03 INFO - Usage: mozinstall [options] installer 03:31:03 INFO - Options: 03:31:03 INFO - -h, --help show this help message and exit 03:31:03 INFO - -d DEST, --destination=DEST 03:31:03 INFO - Directory to install application into. [default: 03:31:03 INFO - "/builds/slave/test"] 03:31:03 INFO - --app=APP Application being installed. [default: firefox] 03:31:03 INFO - mkdir: /builds/slave/test/build/application 03:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:31:19 INFO - Reading from file tmpfile_stdout 03:31:19 INFO - Output received: 03:31:19 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Finished install step (success) 03:31:19 INFO - ##### 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running run-tests step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: run_tests 03:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:19 INFO - Python 2.7.3 03:31:19 INFO - Return code: 0 03:31:19 INFO - grabbing minidump binary from tooltool 03:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:19 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 0x1c592e0>, '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 0x1bc5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:19 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 03:31:19 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 03:31:19 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 03:31:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:19 INFO - Return code: 0 03:31:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:20 INFO - Return code: 0 03:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:31:20 INFO - Using env: {'DISPLAY': ':0', 03:31:20 INFO - 'HOME': '/home/cltbld', 03:31:20 INFO - 'LANG': 'en_US.UTF-8', 03:31:20 INFO - 'LANGUAGE': 'en_US:en', 03:31:20 INFO - 'LOGNAME': 'cltbld', 03:31:20 INFO - 'MAIL': '/var/mail/cltbld', 03:31:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:20 INFO - 'MOZ_NO_REMOTE': '1', 03:31:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:20 INFO - 'NO_EM_RESTART': '1', 03:31:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:20 INFO - 'PWD': '/builds/slave/test', 03:31:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:20 INFO - 'SHELL': '/bin/bash', 03:31:20 INFO - 'SHLVL': '1', 03:31:20 INFO - 'TERM': 'linux', 03:31:20 INFO - 'TMOUT': '86400', 03:31:20 INFO - 'USER': 'cltbld', 03:31:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083', 03:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:20 INFO - '_': '/tools/buildbot/bin/python'} 03:31:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:31:20 INFO - mozversion application_buildid: 20160624021358 03:31:20 INFO - mozversion application_changeset: 34e0a985d93d88be6058db05071121decf373c97 03:31:20 INFO - mozversion application_display_name: Nightly 03:31:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:20 INFO - mozversion application_name: Firefox 03:31:20 INFO - mozversion application_remotingname: firefox 03:31:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:20 INFO - mozversion application_vendor: Mozilla 03:31:20 INFO - mozversion application_version: 50.0a1 03:31:20 INFO - mozversion platform_buildid: 20160624021358 03:31:20 INFO - mozversion platform_changeset: 34e0a985d93d88be6058db05071121decf373c97 03:31:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:20 INFO - mozversion platform_version: 50.0a1 03:31:20 INFO - using testdate: 1466764280 03:31:20 INFO - actual date: 1466764280 03:31:20 INFO - starting webserver on 'localhost:45288' 03:31:20 INFO - SUITE-START | Running 2 tests 03:31:20 INFO - TEST-START | dromaeo_css 03:31:20 INFO - operating with platform_type : linux_ 03:31:20 INFO - Initialising browser for dromaeo_css test... 03:31:20 INFO - TEST-INFO | started process 5415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GqI1W/profile http://localhost:45288/getInfo.html) 03:31:25 INFO - PROCESS | 5415 | __metrics Screen width/height:1600/1200 03:31:25 INFO - PROCESS | 5415 | colorDepth:24 03:31:25 INFO - PROCESS | 5415 | Browser inner width/height: 1024/697 03:31:25 INFO - PROCESS | 5415 | __metrics 03:31:26 ERROR - PROCESS | 5415 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:31:27 INFO - TEST-INFO | 5415: exit 0 03:31:27 INFO - Browser initialized. 03:31:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:27 INFO - TEST-INFO | started process 5537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GqI1W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:39 INFO - PROCESS | 5537 | RSS: Main: 186175488 03:31:39 INFO - PROCESS | 5537 | 03:32:28 INFO - PROCESS | 5537 | 1466764348821 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] 03:34:40 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45288/tests/dromaeo/cssquery-ext.html) 03:34:41 INFO - PROCESS | 5537 | RSS: Main: 189505536 03:34:41 INFO - PROCESS | 5537 | 03:37:44 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-ext.html (next: http://localhost:45288/tests/dromaeo/cssquery-jquery.html) 03:37:44 INFO - PROCESS | 5537 | RSS: Main: 187973632 03:37:44 INFO - PROCESS | 5537 | 03:40:46 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45288/tests/dromaeo/cssquery-mootools.html) 03:40:47 INFO - PROCESS | 5537 | RSS: Main: 189673472 03:40:47 INFO - PROCESS | 5537 | 03:43:49 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45288/tests/dromaeo/cssquery-prototype.html) 03:43:49 INFO - PROCESS | 5537 | RSS: Main: 187273216 03:43:49 INFO - PROCESS | 5537 | 03:46:52 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45288/tests/dromaeo/cssquery-yui.html) 03:46:53 INFO - PROCESS | 5537 | RSS: Main: 189071360 03:46:53 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:45288/tests/dromaeo/cssquery-yui.html (next: http://localhost:45288/tests/dromaeo/cssquery-dojo.html) 03:49:55 INFO - PROCESS | 5537 | RSS: Main: 189935616 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | __start_tp_report 03:49:55 INFO - PROCESS | 5537 | _x_x_mozilla_page_load 03:49:55 INFO - PROCESS | 5537 | _x_x_mozilla_page_load_details 03:49:55 INFO - PROCESS | 5537 | |i|pagename|runs| 03:49:55 INFO - PROCESS | 5537 | |0;dojo.html;2634.841909485431;2689.1529168311968;2705.147878418298;2716.9456610867783;2724.2644485988785;4811.2783082537635;4876.439209490905;4883.682560633556;4942.085714142881;4947.628927830418;4779.1397548441355;4868.075065737507;4877.658563900528;4891.926621100686;4907.386576677915;4426.2475379185535;4474.23937930551;4591.517890621487;4601.884952876188;4610.423697037871;527.8508219232057;4421.115776844644;4499.797509112082;4513.074819661978;4588.816447342119;4478.216312145361;4479.641628669715;4479.924818043679;4492.52828453011;4555.63554915606;4454.465464144291;4506.909861802746;4528.456585209763;4534.9546504534865;4535.931961020588;4433;4483.708558943658;4499.392582001421;4543.7728113594185;4555.088982203572;4876.780544875453;4912.214045752698;4941.901161976776;4953.0589188054155;5011.173156429185;5145.974270128663;5156.587473002151;5176.352955880515;5323;5331.386890507563;5233.319668443078;5271.262023316739;5275.60432967529;5283.969625922947;5324.92012619811;4874.7562621868765;4882.609391248762;4890.657653964188;4897.828575999894;4940.456549779521;5311.28297679816;5373.194020896896;5395.892082158335;5423.29497165366;5426.9185962210595;5233.188855727369;5247.055530004636;5247.344081989751;5252.973735131376;5255.816046438356;5330.946690533045;5332.493413125747;5339.519443250048;5339.733013349394;5420;5034.993001399735;5169.06956747789;5205.505476979681;5226.111561034557;5226.947730522722;5042.823501177441;5161.303224064778;5165.070287348238;5211.296474975906;5217.373915130209;4489.73061616304;4494.865154045384;4497.977510112429;4508.32375143731;4554.931676024862;3835.4438606401914;3857.5949525300002;3865.9613403866165;3885.9611403886165;3901.8244179012013;4558.749268790249;4561.977190114095;4563.201439748031;4603.263477843529;4608.815647374067;5202.557782588447;5299.814506492255;5341.198820177005;5342.465753424704;5353.143497040533;4490.910181796411;4539.024109816405;4549.226631472591;4553.385292985471;4561.29299958507;4738.573528382462;4764.785584648699;4769.618430525549;4779.498152693986;4782.569568738831;4804.759762011816;4924.975375123173;4929.630277729113;4936.432310284364;4953.826616068421;5303.946960530499;5350.30446042012;5361.758720857492;5378.919316210338;5417;4965.0566392385335;4976.477469865612;4978.800847966186;4994.675346102492;5018.899622007466;5065.949340506695;5123.641345105956;5145.022445735298;5268.841934741964;5272.551833094077;5240.71176085319;5248.448912864247;5256.369235691742;5266.78932842682;5294.444083371191;5061.089003979319;5095.006473737734;5101.51535604117;5118.948810511847;5131.384233891957;4976.353074100344;5072.619553533574;5089.592832573459;5096.668716533413;5099.745012749274;4895.143349913679;5012.674176178537;5044.092063428471;5078.263651770547;5108.642395032312;5259.184826351921;5264.394594621667;5272.077386457431;5273.26174335601;5316.7075810830775;4938.654294199371;5050.3434553507805;5081.4918508148885;5154.664946778447;5170.1986192140275 03:49:55 INFO - PROCESS | 5537 | |1;ext.html;532.7019828351582;579.9739011744471;593.7446897833933;597.4503456819725;610.5512448350458;33676;37631.81184094079;37639.247215055715;37757.24485510295;37844;38165;38873.41689874654;38875.416868746994;38890.611093889056;38935.805320973355;7720.382369410462;7834.490758100734;7864.4888082274465;7872.370210383156;7884.763457096267;7625.885611715828;7719;7780.649870755801;7791.22087791222;7830.412719046066;7860.646270917822;7882.330001949841;7895.921040789604;7906.407019473534;7908.051033875943;7795.5712435816;7814.882776758382;7837.373010159202;7843.568603726792;7848.68605255789;7684.116326622454;7742.070951485802;7774.144844067148;7775;7779.455438119334;29209.707902920913;36238.45642315367;37086.258274834356;37087;37116.628833711584;2817.7886658500693;2927.9514796612;3079.337942342407;3096.1330827368374;3272.5745653065187;27282.863585682142;27547.449051018866;27615.58576621332;27780.58329125065;28129.437411251864;3253.8535765890592;3356.3958487472246;3369;3425.417678994577;3460.498227756961;213349.99999999846;214721;215273;216220;216710;30424.239394015327;31109.22226944299;31115;31117;31163.220919477193;32092.518612220836;32571.674283257336;32836.3432731344;34276.48585271223;34341.56584341546;14892.776608350883;15173.165475898932;15184;15235.085894846345;15264.16047117397;10816.351018938889;10871.402072886067;10933.726656833644;10942.124630029579;10942.945285273523;17886.195121219316;17937.103144842706;17960.910195448938;18006.549836253937;18022.91862488255;6531.444827189647;6642.634655094016;6770.932290677129;6794.592324460548;6802.503449241159;764.6635480388611;859.3554833874595;945.9716208513755;966.9661561845302;989.1888651306004;26981.730182698313;28111.718882811318;28209.858950705115;28349;28564.428711425655;967.3132076225818;970.669972209438;1004.8593196952432;1032.736652153696;1053.8103141434615;14449.638759031108;14787.482438114614;15030.098194108388;15037.172955487335;15213.087214767149;394948.20207191963;401231;402564;402718;403076;49318;49544.75227623839;50185;50329;50555;1137.0505627800715;1143.4740019590915;1183.1067544004393;1188.738477534941;1188.7919614067503;26054.60918086268;27303.317417064733;27387.31531711723;27777.166684999484;27796.44407111887;41193.794031029654;41362;41690.37464437975;41757.37363939483;41856.58143418527;341248;342712;342921;343762;344296;24503.632445512976;24947.75052249454;25049.499010020063;25084.49831003406;25144.497110058062;42316.78841605772;42377;42764;43012.569874302106;43420;35822.82088589645;36257.27485450329;36270.27459450849;36291.274174515835;36763.44854827233;35171;35913.46129808107;36165.819170903975;36496.63503364933;39404.80297598494;35765.1058723534;36216.27567448689;36260;36370;36627.816860915525;31065;32518.83740581282;32962.83518582488;33201.667983320825;33382.33235335328;25290.241292761246;25407.237782866545;25485.70628643431;25687.74312256928;25993.480130397664 03:49:55 INFO - PROCESS | 5537 | |2;jquery.html;370.15419765835054;370.72936756168014;376.3846111607521;386.76020867062425;389.8206824860564;15681.882945802314;16107.677846443079;16828.158592070376;16881.831181688194;16908.239129239184;15487.303071361788;15759.60600984976;16155.515334539954;16269.186540672978;16278.674426511463;4987.975060124703;5165.173572228444;5198.428172900978;5209.687418754868;5228.712420816853;3702.5556933167923;5103.800606857386;5796.30444346679;6085.087236914454;6094.238220222473;6077.270727512705;6115.663638499881;6138.202033735631;6149.046897730859;6170.629762214281;5097.209932460474;5383.703896285683;5384.3538775346815;5461.726913654302;5477.589180811455;5004.299398084271;5072.731817045738;5091.46539613339;5106.8212612558755;5210;12358.75282494354;12430.875691243153;12452.439640216213;16687.666246675;20441.28455504065;1714.7856517935259;1833.3583245863974;1904.8761830480973;1918.8273055424938;2429.842060266095;8823.338249631302;9062.184403403659;9152.542372881397;9208.953955230249;9305.627774888997;1646.4895882276533;1664.8002239731188;1703.1824724132487;1708.4789139312504;1796.7484552162707;62296;66240.66879665619;66540.33459665439;67094.66452667705;67321;9732.318737688294;9991.501274808692;10080.445575493271;10152.39085654863;10223.7444063899;13801.861981380258;13871.445142194401;13890;13923.721525569432;13961.720765584834;7304.96347518259;7315.195328513859;7497.550146991089;7584.089909210819;7638.312551870358;7178.246284140195;7228.277172282729;7233.8553228935125;7321.524100933422;7341.926580734124;4312.353147027971;4331.6318112960125;4381.408509851193;4385.7149285296355;4473.731576105444;1561.757927521236;1746.9825301746819;1796.7035439152655;1823.489422961573;1859.2191279662575;732.8937304090983;776.3827756933251;800.3917023062514;813.6175997281268;862.2153840005565;15869.68260634781;16336.509904702878;16450.917745411196;16463.012219266882;16530.504084877473;827.9296259817862;860.2988564320059;861.4745005546612;863.9481631102028;901.5221932375852;9159.633614655339;9276.536173191313;9339.439633622005;9346.859797103049;9400.15398614128;404124;404529;406545;407914;425216;74825;76419;77520;77772;78256.60871695605;891.6567121658209;909.1454033208763;923.6582464488048;925.3984909808678;925.4077390470104;13041;14692.485762998243;14775.778363324343;14956.551303460914;15132.621684457976;24900.875495622407;26516.337091572866;26674.59988100219;34684.65315346814;34700.13249668779;49468.03191808503;49750.75124624354;51220;51330;51736.482635174674;6655.866882662416;7038.436925045881;7092.9645351772915;7458.440616953859;7518.436117291116;11432;11545.88454115448;11617.593384231512;11692.415379230833;11848.76302473963;10043.096121349114;10110.494475276353;10152.695419137437;10197;10402.635907743193;9467.715968520955;9974.800503990025;10256.665786365898;10313.381197128196;10488.947555262175;9559.761005974906;9991.850122248026;10098.091171794575;10155.543000564845;10176.847347289648;6379.74481020754;6716.83207919806;7704.383649308154;7811.101723301893;7910.446268761131;5206.635535512478;9419.481928493999;10372.636957706443;10446.947765261126;10724.356538607708 03:49:55 INFO - PROCESS | 5537 | |3;mootools.html;1356.2811709793814;1385.3073463268365;1442.156338541953;1623.131624580848;1629.470422112813;6727.394534491895;7390;7547.924520754791;7882.645280962356;7896.48672836266;7609.353204977583;7758.8448231035345;7787;7827.21727827217;7833.138354780984;2138.893055347234;2171.4028642123462;2183.475965768212;2196.978030219693;2196.9890150549227;2156.223759446598;2173.022140036982;2203.22886989554;2203.2508946958033;2210.45843768277;2174.9342822017175;2202.3282898715884;2203.867767933929;2207.558488302338;2233.8101261392803;2163.891805409723;2175.434387059368;2197.659362798761;2201.625723626987;2205.0518277140823;2113.3871177358546;2142.3572928121657;2149.8065174134244;2184.748753893291;2189.6168170570245;7937.920620793833;7946.284834364935;7970.163132871081;7995.840083198362;8005.159458256916;4509.932351014738;4616.0767846430845;4649.209634362167;4655.998960223568;4660.137874493195;2793.608894754736;2891.0459548349204;2924.2981684395804;2934.7212014858555;2936.0898121582163;900.8468560344758;911.3574929674563;949.8005418862048;950.1923365139645;957.7509847439646;10459.529321180566;10588.894111058868;10650.307729997525;10659.626913058084;10718.732031699192;4049.8987525312104;4146.460960075231;4234.809433575497;4248.320268757046;4252.808623611945;9206.815863682823;9216.907830921606;9233.445993240428;9237.584308706124;9292.72121836346;4666.60333871618;4674.906501870011;4685.5782979532005;4691.413573303337;4693;3625.8912232633065;4163.333866581393;4283.271843786564;4290.699651024461;4333.371661109121;3647;3684.8526058957877;3743.026813028632;3743.6630703236838;3805.429185622179;1178.8231765235284;1193.8507686539183;1193.9343336116597;1195.623378635727;1205.4816428935642;682.3926705232348;793.3851265269348;795.5862951265425;811.111832543364;813.4346629092723;5003.2995380646735;5166.844994650167;5252.868678283074;5257.63196576236;5262.60530460217;411.8990847242385;412.38348668740423;420.7160166887339;425.4405456824266;435.29264944465245;3509.771864828829;3564.1624218308675;3586.103474131467;3597.8201089945924;3610.765300255475;9197.540122993823;9416.576254068446;9579.042095790364;9579.856302155473;9605.519724013771;9415.623375065057;9454.00732923047;9457.763555911157;9462.763430914281;9499.287553433382;6886.001529778255;6941.826454338682;6957.304269573104;6979.4765392595755;6994.965025174842;5094.414142373526;5106.387233532;5127.2565478004735;5252.238425428215;5332.360116786011;8762.912370876209;8770.210681038738;8827.426217295855;8830.867536986822;8881.689140880038;8737.475751454933;8950.373473857027;9056.683016094405;9104.726858194264;9172.403793753652;5752.453516915886;6495.772647957298;6559.212894452697;6629.801105966829;6694.564853284521;7279.381252593589;7317.487775855639;7331.450141239535;7378.5941773202985;7417.517861338995;6616.603003819786;6786.117804685359;6825.522213445011;6876.277990810893;6927.826804329932;6667.733290668319;6694.531382803157;6752.08846805675;6793.762218322335;6922.480813938874;5597.132444471114;5671.801486947937;5686.829395118153;5698.800541981011;5713.371529131709;4567.337736028324;4581.473130589891;4673.906521869611;4699.953000470088;4704.411948506437;4485.125400546862;4521;4543.750093744876;4632.791524381479;4712.198926182488 03:49:55 INFO - PROCESS | 5537 | |4;prototype.html;294.62729646996553;303.15873451173;305.1455923414439;306.64888702435707;312.19765203427204;4898.412190537131;5036.269740887569;5055.823046193384;5120.871978200546;5162.406323272825;5082.161443361841;5089.389273287202;5105.132127538318;5111.591072714184;5118.33461649985;3943.6056394360476;3967.404889266604;3980.960190398088;3981.263466258737;3987.8404863805413;3885.4754608127964;3976.4234186043004;3994.241094192109;4003.7998100095024;4008.3586626139822;3934;3938.960610393888;3952.288588054149;3955.16941442296;3965.4646622706;3959.1685745993377;3963.128111815396;3963.46493223414;3963.6829053675638;3979.090036782332;3377.392069427502;3471.114865709228;3520.626955487362;3527.664871837171;3532;4979.45226025137;5014.52362025607;5029.2958985742025;5037.319961805146;5042.546170844642;4597.241455159895;4613.339197888758;4619.12236675034;4623.69945953512;4624.537546245382;5265.710385928773;5369.194620806871;5398.973005134989;5409.756560954727;5427.972860135674;3842.7117966152373;3866.2074274773604;3869.845206191777;3878.941815872764;3895.2404281165186;5571.387147413781;5601.523870471015;5620.4098569650005;5625.268715067056;5658.349289831681;3735.869244576481;3963.147923196527;3966.2662407454714;4021.1756589899;4048.1903619276263;3972.662323702518;4008.8596899108975;4015.634684207325;4023.3964905264443;4038.374052021941;4519.751413672279;4550.931736023962;4555.407796986437;4567.13224487353;4598.88502787433;5218.947810521922;5366.838994830161;5383.488568585978;5413;5433.755481003364;1289.7162624222656;1372.7117305365784;1402.859714028589;1404.4171668757556;1407.7677183264648;881.8633111867671;888.1518150166576;891.7012800711705;905.5472263868066;914.4787471141385;4107.466029416157;4142.834286628501;4167.74993500391;4201.495820501498;4206.516250631155;4818.229083346718;4865.781039853215;4876.439209490883;4877.6341774367065;4957.3059771632;4174.478190226222;4197.223513649985;4210.95768552252;4258.233517966733;4269.23153832307;2419.5535406297877;2592.727763584834;2616.6205900144373;2617.869106544665;2620.4497055618153;4553.54464553542;4573.336866154389;4582.739746569653;4585.335126406652;4608.953910460919;4931.7040977541465;4965.4041515018425;4980.626453015966;4981.526754958273;4994.500549944976;4329.935050974238;4589.954100459019;4599.425071866017;4612.630989520831;4622.976885115553;4828.493008234085;4870.415550133865;4893.828715994923;4896.510348965075;4927.817323842324;4728.3380326753595;4748.928766068442;4755.714657120584;4771.761411929459;4784.354112194809;4244.236037513278;4509.706869053501;4517.277235642281;4544.341070544819;4591.931121033121;3534.6642069003406;3565.23347480293;3577.2130131371055;3585.2751908549167;3589.353916295092;4820.951095784348;4893.853184404474;4893.951060489349;5278.392984806643;5445.26488924006;5318.606627017934;5331;5336.226247194213;5341.919871201857;5361.597880158925;5275.261463395204;5347.449239720438;5385.27298814655;5410.918836217538;5423.430539793265;5073.771680274471;5230.137027390438;5301.628885977944;5304.602154838325;5313.574914006947;5364.30264065669;5368.32895888014;5385.946140538545;5402.459754024566;5405.918911216257;5270.341207349082;5295.894082118413;5297.894042119213;5299.417064122867;5301.496357845998 03:49:55 INFO - PROCESS | 5537 | |5;yui.html;551.713109183225;552.6214543038017;695.3046953046953;730;786.5949036246334;12619.684507887307;13406.128601640887;13464.394102265409;13490.190588564694;13533.593992180226;11962.700932476671;12219.694507637314;12281.754364912696;12493.063020273494;12902;762.5119923249139;774.2412435812906;781.6951388958311;781.9335356494705;787.4055088408244;790.4901338636575;793.0681449297082;794.8291117409756;796.1282395776644;797.8284668796208;834.0241916957144;838.4801423117646;843.7510934274404;846.8137009857852;847.8050048488851;829.1873963515728;835.7952301686096;837.4305472278847;837.5100566168799;841.5750046226677;603.1826874584918;606.754264522869;606.9453749162552;607.6748939317444;608.5770389579244;11387.08903287735;11581.247218930826;11600.12999025068;11627.709307267301;11650.825237621442;10906.127509799277;10998.450077496173;11170.609028684039;11346.149038822121;11429.199956003084;9049.457032578066;9171.797418073485;9211.677591284273;9355.859662105075;9470.715878523655;3264.689854463822;3323.3187196624635;3368.831558422069;3370.5449764282;3435.587729472479;52849.207261891104;54456.727716361165;54489.72755136199;54666.72666636681;54891.17663235054;9758.365706229073;9867.506624668738;9908.653197138066;9914.80170396588;10049.59801607942;16878.66242675164;17934.19296131677;18220.90889545544;18315.816841831678;18318.26726930908;6972.686229119702;7252.746153884589;7258.455615828834;7409.073865766779;7525.6989720410575;3754.662080412776;3772.641599048086;3827.655511004023;3867.903302417462;3944.822482988215;2850.144956513038;2943.470175368411;2946.3076177098364;2969.4209629122547;2979.61265035544;490.91899836526574;503.0969409909222;512.4747134187488;513.5480776916289;520.5575261028172;581.3982528083413;593.3265743381294;624.9750009999549;630.2846269484169;632.1466020871878;7628.427867909929;7892.684292628231;7959.761207163794;8053.1946805319;8352.039515455679;599.409581562161;624.7875722254364;624.9812505624839;636.0427556527396;636.3000699230809;3783.7162212834146;3795.221979494197;3803.6386543278345;3922.1371298314325;3963.4451176835264;88628.11371886327;89928;90114;93056.53471732598;93465.53267233756;80085.59957200177;81137.59431202806;81615;82318.58840705758;83508;45186.32220516695;46686.29970550445;59122;66398.99999999904;71073.2892671077;7207.207207207098;7262.527935684164;7306.465642215195;7498.512596681198;7534.773956781305;43034.35448468338;43269.567304327815;43984;44354;44547.55452445434;54268.45731542792;54270;63697.363026369145;63907;64659.353406465336;10619;10878.673639790819;11339.433028348714;11454.427278636202;11610.361430121087;11410.885891140982;12136.33250171249;12458.127931045103;12733.55432559856;12738.235705857678;10665.146788257076;11192.440377980905;11301.830472542753;11671.76656466883;13151;11051.778964420828;11353.659390218307;11466.885331146581;11585.536578537101;11635.941820290844;10628.415437150721;10837.512311946139;10883.891161088604;10885.727856803644;11649.534018639159;9446.149846513847;9511.286653500876;9585.28544161005;9778.9022109778;9995.70012899614;9926.801463970825;10081.798364032531;10178.236632252463;10230.846537301797;10235.385876847413 03:49:55 INFO - PROCESS | 5537 | __end_tp_report 03:49:55 INFO - PROCESS | 5537 | __start_cc_report 03:49:55 INFO - PROCESS | 5537 | _x_x_mozilla_cycle_collect,403 03:49:55 INFO - PROCESS | 5537 | __end_cc_report 03:49:55 INFO - PROCESS | 5537 | __startTimestamp1466765395714__endTimestamp 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | ------- Summary: start ------- 03:49:55 INFO - PROCESS | 5537 | Number of tests: 6 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#0] dojo.html Cycles:165 Average:4839.17 Median:4976.48 stddev:620.74 (12.5%) stddev-sans-first:598.08 03:49:55 INFO - PROCESS | 5537 | Values: 2634.8 2689.2 2705.1 2716.9 2724.3 4811.3 4876.4 4883.7 4942.1 4947.6 4779.1 4868.1 4877.7 4891.9 4907.4 4426.2 4474.2 4591.5 4601.9 4610.4 527.9 4421.1 4499.8 4513.1 4588.8 4478.2 4479.6 4479.9 4492.5 4555.6 4454.5 4506.9 4528.5 4535.0 4535.9 4433.0 4483.7 4499.4 4543.8 4555.1 4876.8 4912.2 4941.9 4953.1 5011.2 5146.0 5156.6 5176.4 5323.0 5331.4 5233.3 5271.3 5275.6 5284.0 5324.9 4874.8 4882.6 4890.7 4897.8 4940.5 5311.3 5373.2 5395.9 5423.3 5426.9 5233.2 5247.1 5247.3 5253.0 5255.8 5330.9 5332.5 5339.5 5339.7 5420.0 5035.0 5169.1 5205.5 5226.1 5226.9 5042.8 5161.3 5165.1 5211.3 5217.4 4489.7 4494.9 4498.0 4508.3 4554.9 3835.4 3857.6 3866.0 3886.0 3901.8 4558.7 4562.0 4563.2 4603.3 4608.8 5202.6 5299.8 5341.2 5342.5 5353.1 4490.9 4539.0 4549.2 4553.4 4561.3 4738.6 4764.8 4769.6 4779.5 4782.6 4804.8 4925.0 4929.6 4936.4 4953.8 5303.9 5350.3 5361.8 5378.9 5417.0 4965.1 4976.5 4978.8 4994.7 5018.9 5065.9 5123.6 5145.0 5268.8 5272.6 5240.7 5248.4 5256.4 5266.8 5294.4 5061.1 5095.0 5101.5 5118.9 5131.4 4976.4 5072.6 5089.6 5096.7 5099.7 4895.1 5012.7 5044.1 5078.3 5108.6 5259.2 5264.4 5272.1 5273.3 5316.7 4938.7 5050.3 5081.5 5154.7 5170.2 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#1] ext.html Cycles:180 Average:46076.05 Median:35468.05 stddev:86910.47 (245.0%) stddev-sans-first:87087.01 03:49:55 INFO - PROCESS | 5537 | Values: 532.7 580.0 593.7 597.5 610.6 33676.0 37631.8 37639.2 37757.2 37844.0 38165.0 38873.4 38875.4 38890.6 38935.8 7720.4 7834.5 7864.5 7872.4 7884.8 7625.9 7719.0 7780.6 7791.2 7830.4 7860.6 7882.3 7895.9 7906.4 7908.1 7795.6 7814.9 7837.4 7843.6 7848.7 7684.1 7742.1 7774.1 7775.0 7779.5 29209.7 36238.5 37086.3 37087.0 37116.6 2817.8 2928.0 3079.3 3096.1 3272.6 27282.9 27547.4 27615.6 27780.6 28129.4 3253.9 3356.4 3369.0 3425.4 3460.5 213350.0 214721.0 215273.0 216220.0 216710.0 30424.2 31109.2 31115.0 31117.0 31163.2 32092.5 32571.7 32836.3 34276.5 34341.6 14892.8 15173.2 15184.0 15235.1 15264.2 10816.4 10871.4 10933.7 10942.1 10942.9 17886.2 17937.1 17960.9 18006.5 18022.9 6531.4 6642.6 6770.9 6794.6 6802.5 764.7 859.4 946.0 967.0 989.2 26981.7 28111.7 28209.9 28349.0 28564.4 967.3 970.7 1004.9 1032.7 1053.8 14449.6 14787.5 15030.1 15037.2 15213.1 394948.2 401231.0 402564.0 402718.0 403076.0 49318.0 49544.8 50185.0 50329.0 50555.0 1137.1 1143.5 1183.1 1188.7 1188.8 26054.6 27303.3 27387.3 27777.2 27796.4 41193.8 41362.0 41690.4 41757.4 41856.6 341248.0 342712.0 342921.0 343762.0 344296.0 24503.6 24947.8 25049.5 25084.5 25144.5 42316.8 42377.0 42764.0 43012.6 43420.0 35822.8 36257.3 36270.3 36291.3 36763.4 35171.0 35913.5 36165.8 36496.6 39404.8 35765.1 36216.3 36260.0 36370.0 36627.8 31065.0 32518.8 32962.8 33201.7 33382.3 25290.2 25407.2 25485.7 25687.7 25993.5 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#2] jquery.html Cycles:180 Average:24262.12 Median:4996.14 stddev:67487.12 (1350.8%) stddev-sans-first:67652.59 03:49:55 INFO - PROCESS | 5537 | Values: 370.2 370.7 376.4 386.8 389.8 15681.9 16107.7 16828.2 16881.8 16908.2 15487.3 15759.6 16155.5 16269.2 16278.7 4988.0 5165.2 5198.4 5209.7 5228.7 3702.6 5103.8 5796.3 6085.1 6094.2 6077.3 6115.7 6138.2 6149.0 6170.6 5097.2 5383.7 5384.4 5461.7 5477.6 5004.3 5072.7 5091.5 5106.8 5210.0 12358.8 12430.9 12452.4 16687.7 20441.3 1714.8 1833.4 1904.9 1918.8 2429.8 8823.3 9062.2 9152.5 9209.0 9305.6 1646.5 1664.8 1703.2 1708.5 1796.7 62296.0 66240.7 66540.3 67094.7 67321.0 9732.3 9991.5 10080.4 10152.4 10223.7 13801.9 13871.4 13890.0 13923.7 13961.7 7305.0 7315.2 7497.6 7584.1 7638.3 7178.2 7228.3 7233.9 7321.5 7341.9 4312.4 4331.6 4381.4 4385.7 4473.7 1561.8 1747.0 1796.7 1823.5 1859.2 732.9 776.4 800.4 813.6 862.2 15869.7 16336.5 16450.9 16463.0 16530.5 827.9 860.3 861.5 863.9 901.5 9159.6 9276.5 9339.4 9346.9 9400.2 404124.0 404529.0 406545.0 407914.0 425216.0 74825.0 76419.0 77520.0 77772.0 78256.6 891.7 909.1 923.7 925.4 925.4 13041.0 14692.5 14775.8 14956.6 15132.6 24900.9 26516.3 26674.6 34684.7 34700.1 49468.0 49750.8 51220.0 51330.0 51736.5 6655.9 7038.4 7093.0 7458.4 7518.4 11432.0 11545.9 11617.6 11692.4 11848.8 10043.1 10110.5 10152.7 10197.0 10402.6 9467.7 9974.8 10256.7 10313.4 10488.9 9559.8 9991.9 10098.1 10155.5 10176.8 6379.7 6716.8 7704.4 7811.1 7910.4 5206.6 9419.5 10372.6 10446.9 10724.4 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#3] mootools.html Cycles:180 Average:5081.82 Median:5048.86 stddev:2860.95 (56.7%) stddev-sans-first:2855.27 03:49:55 INFO - PROCESS | 5537 | Values: 1356.3 1385.3 1442.2 1623.1 1629.5 6727.4 7390.0 7547.9 7882.6 7896.5 7609.4 7758.8 7787.0 7827.2 7833.1 2138.9 2171.4 2183.5 2197.0 2197.0 2156.2 2173.0 2203.2 2203.3 2210.5 2174.9 2202.3 2203.9 2207.6 2233.8 2163.9 2175.4 2197.7 2201.6 2205.1 2113.4 2142.4 2149.8 2184.7 2189.6 7937.9 7946.3 7970.2 7995.8 8005.2 4509.9 4616.1 4649.2 4656.0 4660.1 2793.6 2891.0 2924.3 2934.7 2936.1 900.8 911.4 949.8 950.2 957.8 10459.5 10588.9 10650.3 10659.6 10718.7 4049.9 4146.5 4234.8 4248.3 4252.8 9206.8 9216.9 9233.4 9237.6 9292.7 4666.6 4674.9 4685.6 4691.4 4693.0 3625.9 4163.3 4283.3 4290.7 4333.4 3647.0 3684.9 3743.0 3743.7 3805.4 1178.8 1193.9 1193.9 1195.6 1205.5 682.4 793.4 795.6 811.1 813.4 5003.3 5166.8 5252.9 5257.6 5262.6 411.9 412.4 420.7 425.4 435.3 3509.8 3564.2 3586.1 3597.8 3610.8 9197.5 9416.6 9579.0 9579.9 9605.5 9415.6 9454.0 9457.8 9462.8 9499.3 6886.0 6941.8 6957.3 6979.5 6995.0 5094.4 5106.4 5127.3 5252.2 5332.4 8762.9 8770.2 8827.4 8830.9 8881.7 8737.5 8950.4 9056.7 9104.7 9172.4 5752.5 6495.8 6559.2 6629.8 6694.6 7279.4 7317.5 7331.5 7378.6 7417.5 6616.6 6786.1 6825.5 6876.3 6927.8 6667.7 6694.5 6752.1 6793.8 6922.5 5597.1 5671.8 5686.8 5698.8 5713.4 4567.3 4581.5 4673.9 4700.0 4704.4 4485.1 4521.0 4543.8 4632.8 4712.2 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#4] prototype.html Cycles:180 Average:4271.86 Median:4616.23 stddev:1234.46 (26.7%) stddev-sans-first:1201.29 03:49:55 INFO - PROCESS | 5537 | Values: 294.6 303.2 305.1 306.6 312.2 4898.4 5036.3 5055.8 5120.9 5162.4 5082.2 5089.4 5105.1 5111.6 5118.3 3943.6 3967.4 3981.0 3981.3 3987.8 3885.5 3976.4 3994.2 4003.8 4008.4 3934.0 3939.0 3952.3 3955.2 3965.5 3959.2 3963.1 3963.5 3963.7 3979.1 3377.4 3471.1 3520.6 3527.7 3532.0 4979.5 5014.5 5029.3 5037.3 5042.5 4597.2 4613.3 4619.1 4623.7 4624.5 5265.7 5369.2 5399.0 5409.8 5428.0 3842.7 3866.2 3869.8 3878.9 3895.2 5571.4 5601.5 5620.4 5625.3 5658.3 3735.9 3963.1 3966.3 4021.2 4048.2 3972.7 4008.9 4015.6 4023.4 4038.4 4519.8 4550.9 4555.4 4567.1 4598.9 5218.9 5366.8 5383.5 5413.0 5433.8 1289.7 1372.7 1402.9 1404.4 1407.8 881.9 888.2 891.7 905.5 914.5 4107.5 4142.8 4167.7 4201.5 4206.5 4818.2 4865.8 4876.4 4877.6 4957.3 4174.5 4197.2 4211.0 4258.2 4269.2 2419.6 2592.7 2616.6 2617.9 2620.4 4553.5 4573.3 4582.7 4585.3 4609.0 4931.7 4965.4 4980.6 4981.5 4994.5 4329.9 4590.0 4599.4 4612.6 4623.0 4828.5 4870.4 4893.8 4896.5 4927.8 4728.3 4748.9 4755.7 4771.8 4784.4 4244.2 4509.7 4517.3 4544.3 4591.9 3534.7 3565.2 3577.2 3585.3 3589.4 4821.0 4893.9 4894.0 5278.4 5445.3 5318.6 5331.0 5336.2 5341.9 5361.6 5275.3 5347.4 5385.3 5410.9 5423.4 5073.8 5230.1 5301.6 5304.6 5313.6 5364.3 5368.3 5385.9 5402.5 5405.9 5270.3 5295.9 5297.9 5299.4 5301.5 03:49:55 INFO - PROCESS | 5537 | 03:49:55 INFO - PROCESS | 5537 | [#5] yui.html Cycles:180 Average:16510.03 Median:54473.23 stddev:23209.25 (42.6%) stddev-sans-first:23243.42 03:49:55 INFO - PROCESS | 5537 | Values: 551.7 552.6 695.3 730.0 786.6 12619.7 13406.1 13464.4 13490.2 13533.6 11962.7 12219.7 12281.8 12493.1 12902.0 762.5 774.2 781.7 781.9 787.4 790.5 793.1 794.8 796.1 797.8 834.0 838.5 843.8 846.8 847.8 829.2 835.8 837.4 837.5 841.6 603.2 606.8 606.9 607.7 608.6 11387.1 11581.2 11600.1 11627.7 11650.8 10906.1 10998.5 11170.6 11346.1 11429.2 9049.5 9171.8 9211.7 9355.9 9470.7 3264.7 3323.3 3368.8 3370.5 3435.6 52849.2 54456.7 54489.7 54666.7 54891.2 9758.4 9867.5 9908.7 9914.8 10049.6 16878.7 17934.2 18220.9 18315.8 18318.3 6972.7 7252.7 7258.5 7409.1 7525.7 3754.7 3772.6 3827.7 3867.9 3944.8 2850.1 2943.5 2946.3 2969.4 2979.6 490.9 503.1 512.5 513.5 520.6 581.4 593.3 625.0 630.3 632.1 7628.4 7892.7 7959.8 8053.2 8352.0 599.4 624.8 625.0 636.0 636.3 3783.7 3795.2 3803.6 3922.1 3963.4 88628.1 89928.0 90114.0 93056.5 93465.5 80085.6 81137.6 81615.0 82318.6 83508.0 45186.3 46686.3 59122.0 66399.0 71073.3 7207.2 7262.5 7306.5 7498.5 7534.8 43034.4 43269.6 43984.0 44354.0 44547.6 54268.5 54270.0 63697.4 63907.0 64659.4 10619.0 10878.7 11339.4 11454.4 11610.4 11410.9 12136.3 12458.1 12733.6 12738.2 10665.1 11192.4 11301.8 11671.8 13151.0 11051.8 11353.7 11466.9 11585.5 11635.9 10628.4 10837.5 10883.9 10885.7 11649.5 9446.1 9511.3 9585.3 9778.9 9995.7 9926.8 10081.8 10178.2 10230.8 10235.4 03:49:55 INFO - PROCESS | 5537 | -------- Summary: end -------- 03:49:55 INFO - PROCESS | 5537 | 03:49:56 INFO - TEST-INFO | 5537: exit 0 03:49:56 INFO - TEST-OK | dromaeo_css | took 1116105ms 03:49:56 INFO - TEST-START | kraken 03:49:56 INFO - operating with platform_type : linux_ 03:49:56 INFO - Initialising browser for kraken test... 03:49:56 INFO - TEST-INFO | started process 5771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikZBlZ/profile http://localhost:45288/getInfo.html) 03:50:01 INFO - PROCESS | 5771 | __metrics Screen width/height:1600/1200 03:50:01 INFO - PROCESS | 5771 | colorDepth:24 03:50:01 INFO - PROCESS | 5771 | Browser inner width/height: 1024/697 03:50:01 INFO - PROCESS | 5771 | __metrics 03:50:02 ERROR - PROCESS | 5771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:50:03 INFO - TEST-INFO | 5771: exit 0 03:50:03 INFO - Browser initialized. 03:50:03 INFO - Running cycle 1/1 for kraken test... 03:50:03 INFO - TEST-INFO | started process 5891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikZBlZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:15 INFO - PROCESS | 5891 | RSS: Main: 186159104 03:50:15 INFO - PROCESS | 5891 | 03:50:17 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45288/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:18 INFO - PROCESS | 5891 | RSS: Main: 190836736 03:50:18 INFO - PROCESS | 5891 | 03:50:21 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45288/tests/kraken/driver.html?testName=audio-dft) 03:50:22 INFO - PROCESS | 5891 | RSS: Main: 190791680 03:50:22 INFO - PROCESS | 5891 | 03:50:25 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45288/tests/kraken/driver.html?testName=audio-fft) 03:50:25 INFO - PROCESS | 5891 | RSS: Main: 186814464 03:50:25 INFO - PROCESS | 5891 | 03:50:28 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45288/tests/kraken/driver.html?testName=audio-oscillator) 03:50:28 INFO - PROCESS | 5891 | RSS: Main: 186724352 03:50:28 INFO - PROCESS | 5891 | 03:50:30 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:31 INFO - PROCESS | 5891 | RSS: Main: 187224064 03:50:31 INFO - PROCESS | 5891 | 03:50:34 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45288/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:35 INFO - PROCESS | 5891 | RSS: Main: 187453440 03:50:35 INFO - PROCESS | 5891 | 03:50:39 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45288/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:39 INFO - PROCESS | 5891 | RSS: Main: 184627200 03:50:39 INFO - PROCESS | 5891 | 03:50:42 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45288/tests/kraken/driver.html?testName=json-parse-financial) 03:50:43 INFO - PROCESS | 5891 | RSS: Main: 186413056 03:50:43 INFO - PROCESS | 5891 | 03:50:44 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:45 INFO - PROCESS | 5891 | RSS: Main: 186880000 03:50:45 INFO - PROCESS | 5891 | 03:50:47 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:48 INFO - PROCESS | 5891 | RSS: Main: 187109376 03:50:48 INFO - PROCESS | 5891 | 03:50:50 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:51 INFO - PROCESS | 5891 | RSS: Main: 187371520 03:50:51 INFO - PROCESS | 5891 | 03:50:53 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:54 INFO - PROCESS | 5891 | RSS: Main: 187273216 03:50:54 INFO - PROCESS | 5891 | 03:50:57 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:58 INFO - PROCESS | 5891 | RSS: Main: 186683392 03:50:58 INFO - PROCESS | 5891 | 03:50:59 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:45288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45288/tests/kraken/driver.html?testName=ai-astar) 03:51:00 INFO - PROCESS | 5891 | RSS: Main: 187097088 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | __start_tp_report 03:51:00 INFO - PROCESS | 5891 | _x_x_mozilla_page_load 03:51:00 INFO - PROCESS | 5891 | _x_x_mozilla_page_load_details 03:51:00 INFO - PROCESS | 5891 | |i|pagename|runs| 03:51:00 INFO - PROCESS | 5891 | |0;ai-astar;104;114;109;116;115;113;114;112;114;113 03:51:00 INFO - PROCESS | 5891 | |1;audio-beat-detection;153;132;157;180;133;161;160;134;188;133 03:51:00 INFO - PROCESS | 5891 | |2;audio-dft;164;170;173;165;161;166;165;167;162;162 03:51:00 INFO - PROCESS | 5891 | |3;audio-fft;76;82;77;155;77;76;76;75;156;78 03:51:00 INFO - PROCESS | 5891 | |4;audio-oscillator;86;86;158;87;87;87;135;86;88;136 03:51:00 INFO - PROCESS | 5891 | |5;imaging-gaussian-blur;117;117;118;118;119;119;119;118;118;117 03:51:00 INFO - PROCESS | 5891 | |6;imaging-darkroom;148;149;148;147;148;149;148;148;147;147 03:51:00 INFO - PROCESS | 5891 | |7;imaging-desaturate;95;96;96;97;95;96;97;95;95;95 03:51:00 INFO - PROCESS | 5891 | |8;json-parse-financial;65;66;66;66;66;66;65;66;68;66 03:51:00 INFO - PROCESS | 5891 | |9;json-stringify-tinderbox;65;64;65;65;66;65;65;65;65;65 03:51:00 INFO - PROCESS | 5891 | |10;stanford-crypto-aes;83;81;82;89;85;85;90;84;95;86 03:51:00 INFO - PROCESS | 5891 | |11;stanford-crypto-ccm;134;134;132;144;131;130;131;138;146;131 03:51:00 INFO - PROCESS | 5891 | |12;stanford-crypto-pbkdf2;172;171;171;172;176;170;177;180;173;168 03:51:00 INFO - PROCESS | 5891 | |13;stanford-crypto-sha256-iterative;69;67;71;67;75;67;67;69;67;67 03:51:00 INFO - PROCESS | 5891 | __end_tp_report 03:51:00 INFO - PROCESS | 5891 | __start_cc_report 03:51:00 INFO - PROCESS | 5891 | _x_x_mozilla_cycle_collect,1024 03:51:00 INFO - PROCESS | 5891 | __end_cc_report 03:51:00 INFO - PROCESS | 5891 | __startTimestamp1466765460077__endTimestamp 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | ------- Summary: start ------- 03:51:00 INFO - PROCESS | 5891 | Number of tests: 14 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:2.00 03:51:00 INFO - PROCESS | 5891 | Values: 104.0 114.0 109.0 116.0 115.0 113.0 114.0 112.0 114.0 113.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:158.50 stddev:20.23 (12.8%) stddev-sans-first:21.46 03:51:00 INFO - PROCESS | 5891 | Values: 153.0 132.0 157.0 180.0 133.0 161.0 160.0 134.0 188.0 133.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.75 (2.3%) stddev-sans-first:3.94 03:51:00 INFO - PROCESS | 5891 | Values: 164.0 170.0 173.0 165.0 161.0 166.0 165.0 167.0 162.0 162.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.50 stddev:33.10 (43.3%) stddev-sans-first:34.55 03:51:00 INFO - PROCESS | 5891 | Values: 76.0 82.0 77.0 155.0 77.0 76.0 76.0 75.0 156.0 78.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:86.50 stddev:27.88 (32.2%) stddev-sans-first:28.83 03:51:00 INFO - PROCESS | 5891 | Values: 86.0 86.0 158.0 87.0 87.0 87.0 135.0 86.0 88.0 136.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 03:51:00 INFO - PROCESS | 5891 | Values: 117.0 117.0 118.0 118.0 119.0 119.0 119.0 118.0 118.0 117.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:51:00 INFO - PROCESS | 5891 | Values: 148.0 149.0 148.0 147.0 148.0 149.0 148.0 148.0 147.0 147.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 03:51:00 INFO - PROCESS | 5891 | Values: 95.0 96.0 96.0 97.0 95.0 96.0 97.0 95.0 95.0 95.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 03:51:00 INFO - PROCESS | 5891 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 68.0 66.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 03:51:00 INFO - PROCESS | 5891 | Values: 65.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.50 stddev:4.24 (5.0%) stddev-sans-first:4.36 03:51:00 INFO - PROCESS | 5891 | Values: 83.0 81.0 82.0 89.0 85.0 85.0 90.0 84.0 95.0 86.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:134.00 stddev:5.72 (4.3%) stddev-sans-first:6.06 03:51:00 INFO - PROCESS | 5891 | Values: 134.0 134.0 132.0 144.0 131.0 130.0 131.0 138.0 146.0 131.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:172.50 stddev:3.62 (2.1%) stddev-sans-first:3.82 03:51:00 INFO - PROCESS | 5891 | Values: 172.0 171.0 171.0 172.0 176.0 170.0 177.0 180.0 173.0 168.0 03:51:00 INFO - PROCESS | 5891 | 03:51:00 INFO - PROCESS | 5891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:2.63 (3.9%) stddev-sans-first:2.79 03:51:00 INFO - PROCESS | 5891 | Values: 69.0 67.0 71.0 67.0 75.0 67.0 67.0 69.0 67.0 67.0 03:51:00 INFO - PROCESS | 5891 | -------- Summary: end -------- 03:51:00 INFO - PROCESS | 5891 | 03:51:01 INFO - TEST-INFO | 5891: exit 0 03:51:01 INFO - TEST-OK | kraken | took 64712ms 03:51:01 INFO - SUITE-END | took 1180s 03:51:01 INFO - Completed test suite (00:19:41) 03:51:01 INFO - javascript benchmark 03:51:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6334.559530750576, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.841909485431, 2689.1529168311968, 2705.147878418298, 2716.9456610867783, 2724.2644485988785, 4811.2783082537635, 4876.439209490905, 4883.682560633556, 4942.085714142881, 4947.628927830418, 4779.1397548441355, 4868.075065737507, 4877.658563900528, 4891.926621100686, 4907.386576677915, 4426.2475379185535, 4474.23937930551, 4591.517890621487, 4601.884952876188, 4610.423697037871, 527.8508219232057, 4421.115776844644, 4499.797509112082, 4513.074819661978, 4588.816447342119, 4478.216312145361, 4479.641628669715, 4479.924818043679, 4492.52828453011, 4555.63554915606, 4454.465464144291, 4506.909861802746, 4528.456585209763, 4534.9546504534865, 4535.931961020588, 4433.0, 4483.708558943658, 4499.392582001421, 4543.7728113594185, 4555.088982203572, 4876.780544875453, 4912.214045752698, 4941.901161976776, 4953.0589188054155, 5011.173156429185, 5145.974270128663, 5156.587473002151, 5176.352955880515, 5323.0, 5331.386890507563, 5233.319668443078, 5271.262023316739, 5275.60432967529, 5283.969625922947, 5324.92012619811, 4874.7562621868765, 4882.609391248762, 4890.657653964188, 4897.828575999894, 4940.456549779521, 5311.28297679816, 5373.194020896896, 5395.892082158335, 5423.29497165366, 5426.9185962210595, 5233.188855727369, 5247.055530004636, 5247.344081989751, 5252.973735131376, 5255.816046438356, 5330.946690533045, 5332.493413125747, 5339.519443250048, 5339.733013349394, 5420.0, 5034.993001399735, 5169.06956747789, 5205.505476979681, 5226.111561034557, 5226.947730522722, 5042.823501177441, 5161.303224064778, 5165.070287348238, 5211.296474975906, 5217.373915130209, 4489.73061616304, 4494.865154045384, 4497.977510112429, 4508.32375143731, 4554.931676024862, 3835.4438606401914, 3857.5949525300002, 3865.9613403866165, 3885.9611403886165, 3901.8244179012013, 4558.749268790249, 4561.977190114095, 4563.201439748031, 4603.263477843529, 4608.815647374067, 5202.557782588447, 5299.814506492255, 5341.198820177005, 5342.465753424704, 5353.143497040533, 4490.910181796411, 4539.024109816405, 4549.226631472591, 4553.385292985471, 4561.29299958507, 4738.573528382462, 4764.785584648699, 4769.618430525549, 4779.498152693986, 4782.569568738831, 4804.759762011816, 4924.975375123173, 4929.630277729113, 4936.432310284364, 4953.826616068421, 5303.946960530499, 5350.30446042012, 5361.758720857492, 5378.919316210338, 5417.0, 4965.0566392385335, 4976.477469865612, 4978.800847966186, 4994.675346102492, 5018.899622007466, 5065.949340506695, 5123.641345105956, 5145.022445735298, 5268.841934741964, 5272.551833094077, 5240.71176085319, 5248.448912864247, 5256.369235691742, 5266.78932842682, 5294.444083371191, 5061.089003979319, 5095.006473737734, 5101.51535604117, 5118.948810511847, 5131.384233891957, 4976.353074100344, 5072.619553533574, 5089.592832573459, 5096.668716533413, 5099.745012749274, 4895.143349913679, 5012.674176178537, 5044.092063428471, 5078.263651770547, 5108.642395032312, 5259.184826351921, 5264.394594621667, 5272.077386457431, 5273.26174335601, 5316.7075810830775, 4938.654294199371, 5050.3434553507805, 5081.4918508148885, 5154.664946778447, 5170.1986192140275], "value": 4800.563245833643, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.7019828351582, 579.9739011744471, 593.7446897833933, 597.4503456819725, 610.5512448350458, 33676.0, 37631.81184094079, 37639.247215055715, 37757.24485510295, 37844.0, 38165.0, 38873.41689874654, 38875.416868746994, 38890.611093889056, 38935.805320973355, 7720.382369410462, 7834.490758100734, 7864.4888082274465, 7872.370210383156, 7884.763457096267, 7625.885611715828, 7719.0, 7780.649870755801, 7791.22087791222, 7830.412719046066, 7860.646270917822, 7882.330001949841, 7895.921040789604, 7906.407019473534, 7908.051033875943, 7795.5712435816, 7814.882776758382, 7837.373010159202, 7843.568603726792, 7848.68605255789, 7684.116326622454, 7742.070951485802, 7774.144844067148, 7775.0, 7779.455438119334, 29209.707902920913, 36238.45642315367, 37086.258274834356, 37087.0, 37116.628833711584, 2817.7886658500693, 2927.9514796612, 3079.337942342407, 3096.1330827368374, 3272.5745653065187, 27282.863585682142, 27547.449051018866, 27615.58576621332, 27780.58329125065, 28129.437411251864, 3253.8535765890592, 3356.3958487472246, 3369.0, 3425.417678994577, 3460.498227756961, 213349.99999999846, 214721.0, 215273.0, 216220.0, 216710.0, 30424.239394015327, 31109.22226944299, 31115.0, 31117.0, 31163.220919477193, 32092.518612220836, 32571.674283257336, 32836.3432731344, 34276.48585271223, 34341.56584341546, 14892.776608350883, 15173.165475898932, 15184.0, 15235.085894846345, 15264.16047117397, 10816.351018938889, 10871.402072886067, 10933.726656833644, 10942.124630029579, 10942.945285273523, 17886.195121219316, 17937.103144842706, 17960.910195448938, 18006.549836253937, 18022.91862488255, 6531.444827189647, 6642.634655094016, 6770.932290677129, 6794.592324460548, 6802.503449241159, 764.6635480388611, 859.3554833874595, 945.9716208513755, 966.9661561845302, 989.1888651306004, 26981.730182698313, 28111.718882811318, 28209.858950705115, 28349.0, 28564.428711425655, 967.3132076225818, 970.669972209438, 1004.8593196952432, 1032.736652153696, 1053.8103141434615, 14449.638759031108, 14787.482438114614, 15030.098194108388, 15037.172955487335, 15213.087214767149, 394948.20207191963, 401231.0, 402564.0, 402718.0, 403076.0, 49318.0, 49544.75227623839, 50185.0, 50329.0, 50555.0, 1137.0505627800715, 1143.4740019590915, 1183.1067544004393, 1188.738477534941, 1188.7919614067503, 26054.60918086268, 27303.317417064733, 27387.31531711723, 27777.166684999484, 27796.44407111887, 41193.794031029654, 41362.0, 41690.37464437975, 41757.37363939483, 41856.58143418527, 341248.0, 342712.0, 342921.0, 343762.0, 344296.0, 24503.632445512976, 24947.75052249454, 25049.499010020063, 25084.49831003406, 25144.497110058062, 42316.78841605772, 42377.0, 42764.0, 43012.569874302106, 43420.0, 35822.82088589645, 36257.27485450329, 36270.27459450849, 36291.274174515835, 36763.44854827233, 35171.0, 35913.46129808107, 36165.819170903975, 36496.63503364933, 39404.80297598494, 35765.1058723534, 36216.27567448689, 36260.0, 36370.0, 36627.816860915525, 31065.0, 32518.83740581282, 32962.83518582488, 33201.667983320825, 33382.33235335328, 25290.241292761246, 25407.237782866545, 25485.70628643431, 25687.74312256928, 25993.480130397664], "value": 16899.99030850538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.15419765835054, 370.72936756168014, 376.3846111607521, 386.76020867062425, 389.8206824860564, 15681.882945802314, 16107.677846443079, 16828.158592070376, 16881.831181688194, 16908.239129239184, 15487.303071361788, 15759.60600984976, 16155.515334539954, 16269.186540672978, 16278.674426511463, 4987.975060124703, 5165.173572228444, 5198.428172900978, 5209.687418754868, 5228.712420816853, 3702.5556933167923, 5103.800606857386, 5796.30444346679, 6085.087236914454, 6094.238220222473, 6077.270727512705, 6115.663638499881, 6138.202033735631, 6149.046897730859, 6170.629762214281, 5097.209932460474, 5383.703896285683, 5384.3538775346815, 5461.726913654302, 5477.589180811455, 5004.299398084271, 5072.731817045738, 5091.46539613339, 5106.8212612558755, 5210.0, 12358.75282494354, 12430.875691243153, 12452.439640216213, 16687.666246675, 20441.28455504065, 1714.7856517935259, 1833.3583245863974, 1904.8761830480973, 1918.8273055424938, 2429.842060266095, 8823.338249631302, 9062.184403403659, 9152.542372881397, 9208.953955230249, 9305.627774888997, 1646.4895882276533, 1664.8002239731188, 1703.1824724132487, 1708.4789139312504, 1796.7484552162707, 62296.0, 66240.66879665619, 66540.33459665439, 67094.66452667705, 67321.0, 9732.318737688294, 9991.501274808692, 10080.445575493271, 10152.39085654863, 10223.7444063899, 13801.861981380258, 13871.445142194401, 13890.0, 13923.721525569432, 13961.720765584834, 7304.96347518259, 7315.195328513859, 7497.550146991089, 7584.089909210819, 7638.312551870358, 7178.246284140195, 7228.277172282729, 7233.8553228935125, 7321.524100933422, 7341.926580734124, 4312.353147027971, 4331.6318112960125, 4381.408509851193, 4385.7149285296355, 4473.731576105444, 1561.757927521236, 1746.9825301746819, 1796.7035439152655, 1823.489422961573, 1859.2191279662575, 732.8937304090983, 776.3827756933251, 800.3917023062514, 813.6175997281268, 862.2153840005565, 15869.68260634781, 16336.509904702878, 16450.917745411196, 16463.012219266882, 16530.504084877473, 827.9296259817862, 860.2988564320059, 861.4745005546612, 863.9481631102028, 901.5221932375852, 9159.633614655339, 9276.536173191313, 9339.439633622005, 9346.859797103049, 9400.15398614128, 404124.0, 404529.0, 406545.0, 407914.0, 425216.0, 74825.0, 76419.0, 77520.0, 77772.0, 78256.60871695605, 891.6567121658209, 909.1454033208763, 923.6582464488048, 925.3984909808678, 925.4077390470104, 13041.0, 14692.485762998243, 14775.778363324343, 14956.551303460914, 15132.621684457976, 24900.875495622407, 26516.337091572866, 26674.59988100219, 34684.65315346814, 34700.13249668779, 49468.03191808503, 49750.75124624354, 51220.0, 51330.0, 51736.482635174674, 6655.866882662416, 7038.436925045881, 7092.9645351772915, 7458.440616953859, 7518.436117291116, 11432.0, 11545.88454115448, 11617.593384231512, 11692.415379230833, 11848.76302473963, 10043.096121349114, 10110.494475276353, 10152.695419137437, 10197.0, 10402.635907743193, 9467.715968520955, 9974.800503990025, 10256.665786365898, 10313.381197128196, 10488.947555262175, 9559.761005974906, 9991.850122248026, 10098.091171794575, 10155.543000564845, 10176.847347289648, 6379.74481020754, 6716.83207919806, 7704.383649308154, 7811.101723301893, 7910.446268761131, 5206.635535512478, 9419.481928493999, 10372.636957706443, 10446.947765261126, 10724.356538607708], "value": 7985.831669462698, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.2811709793814, 1385.3073463268365, 1442.156338541953, 1623.131624580848, 1629.470422112813, 6727.394534491895, 7390.0, 7547.924520754791, 7882.645280962356, 7896.48672836266, 7609.353204977583, 7758.8448231035345, 7787.0, 7827.21727827217, 7833.138354780984, 2138.893055347234, 2171.4028642123462, 2183.475965768212, 2196.978030219693, 2196.9890150549227, 2156.223759446598, 2173.022140036982, 2203.22886989554, 2203.2508946958033, 2210.45843768277, 2174.9342822017175, 2202.3282898715884, 2203.867767933929, 2207.558488302338, 2233.8101261392803, 2163.891805409723, 2175.434387059368, 2197.659362798761, 2201.625723626987, 2205.0518277140823, 2113.3871177358546, 2142.3572928121657, 2149.8065174134244, 2184.748753893291, 2189.6168170570245, 7937.920620793833, 7946.284834364935, 7970.163132871081, 7995.840083198362, 8005.159458256916, 4509.932351014738, 4616.0767846430845, 4649.209634362167, 4655.998960223568, 4660.137874493195, 2793.608894754736, 2891.0459548349204, 2924.2981684395804, 2934.7212014858555, 2936.0898121582163, 900.8468560344758, 911.3574929674563, 949.8005418862048, 950.1923365139645, 957.7509847439646, 10459.529321180566, 10588.894111058868, 10650.307729997525, 10659.626913058084, 10718.732031699192, 4049.8987525312104, 4146.460960075231, 4234.809433575497, 4248.320268757046, 4252.808623611945, 9206.815863682823, 9216.907830921606, 9233.445993240428, 9237.584308706124, 9292.72121836346, 4666.60333871618, 4674.906501870011, 4685.5782979532005, 4691.413573303337, 4693.0, 3625.8912232633065, 4163.333866581393, 4283.271843786564, 4290.699651024461, 4333.371661109121, 3647.0, 3684.8526058957877, 3743.026813028632, 3743.6630703236838, 3805.429185622179, 1178.8231765235284, 1193.8507686539183, 1193.9343336116597, 1195.623378635727, 1205.4816428935642, 682.3926705232348, 793.3851265269348, 795.5862951265425, 811.111832543364, 813.4346629092723, 5003.2995380646735, 5166.844994650167, 5252.868678283074, 5257.63196576236, 5262.60530460217, 411.8990847242385, 412.38348668740423, 420.7160166887339, 425.4405456824266, 435.29264944465245, 3509.771864828829, 3564.1624218308675, 3586.103474131467, 3597.8201089945924, 3610.765300255475, 9197.540122993823, 9416.576254068446, 9579.042095790364, 9579.856302155473, 9605.519724013771, 9415.623375065057, 9454.00732923047, 9457.763555911157, 9462.763430914281, 9499.287553433382, 6886.001529778255, 6941.826454338682, 6957.304269573104, 6979.4765392595755, 6994.965025174842, 5094.414142373526, 5106.387233532, 5127.2565478004735, 5252.238425428215, 5332.360116786011, 8762.912370876209, 8770.210681038738, 8827.426217295855, 8830.867536986822, 8881.689140880038, 8737.475751454933, 8950.373473857027, 9056.683016094405, 9104.726858194264, 9172.403793753652, 5752.453516915886, 6495.772647957298, 6559.212894452697, 6629.801105966829, 6694.564853284521, 7279.381252593589, 7317.487775855639, 7331.450141239535, 7378.5941773202985, 7417.517861338995, 6616.603003819786, 6786.117804685359, 6825.522213445011, 6876.277990810893, 6927.826804329932, 6667.733290668319, 6694.531382803157, 6752.08846805675, 6793.762218322335, 6922.480813938874, 5597.132444471114, 5671.801486947937, 5686.829395118153, 5698.800541981011, 5713.371529131709, 4567.337736028324, 4581.473130589891, 4673.906521869611, 4699.953000470088, 4704.411948506437, 4485.125400546862, 4521.0, 4543.750093744876, 4632.791524381479, 4712.198926182488], "value": 4030.4342124743075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.62729646996553, 303.15873451173, 305.1455923414439, 306.64888702435707, 312.19765203427204, 4898.412190537131, 5036.269740887569, 5055.823046193384, 5120.871978200546, 5162.406323272825, 5082.161443361841, 5089.389273287202, 5105.132127538318, 5111.591072714184, 5118.33461649985, 3943.6056394360476, 3967.404889266604, 3980.960190398088, 3981.263466258737, 3987.8404863805413, 3885.4754608127964, 3976.4234186043004, 3994.241094192109, 4003.7998100095024, 4008.3586626139822, 3934.0, 3938.960610393888, 3952.288588054149, 3955.16941442296, 3965.4646622706, 3959.1685745993377, 3963.128111815396, 3963.46493223414, 3963.6829053675638, 3979.090036782332, 3377.392069427502, 3471.114865709228, 3520.626955487362, 3527.664871837171, 3532.0, 4979.45226025137, 5014.52362025607, 5029.2958985742025, 5037.319961805146, 5042.546170844642, 4597.241455159895, 4613.339197888758, 4619.12236675034, 4623.69945953512, 4624.537546245382, 5265.710385928773, 5369.194620806871, 5398.973005134989, 5409.756560954727, 5427.972860135674, 3842.7117966152373, 3866.2074274773604, 3869.845206191777, 3878.941815872764, 3895.2404281165186, 5571.387147413781, 5601.523870471015, 5620.4098569650005, 5625.268715067056, 5658.349289831681, 3735.869244576481, 3963.147923196527, 3966.2662407454714, 4021.1756589899, 4048.1903619276263, 3972.662323702518, 4008.8596899108975, 4015.634684207325, 4023.3964905264443, 4038.374052021941, 4519.751413672279, 4550.931736023962, 4555.407796986437, 4567.13224487353, 4598.88502787433, 5218.947810521922, 5366.838994830161, 5383.488568585978, 5413.0, 5433.755481003364, 1289.7162624222656, 1372.7117305365784, 1402.859714028589, 1404.4171668757556, 1407.7677183264648, 881.8633111867671, 888.1518150166576, 891.7012800711705, 905.5472263868066, 914.4787471141385, 4107.466029416157, 4142.834286628501, 4167.74993500391, 4201.495820501498, 4206.516250631155, 4818.229083346718, 4865.781039853215, 4876.439209490883, 4877.6341774367065, 4957.3059771632, 4174.478190226222, 4197.223513649985, 4210.95768552252, 4258.233517966733, 4269.23153832307, 2419.5535406297877, 2592.727763584834, 2616.6205900144373, 2617.869106544665, 2620.4497055618153, 4553.54464553542, 4573.336866154389, 4582.739746569653, 4585.335126406652, 4608.953910460919, 4931.7040977541465, 4965.4041515018425, 4980.626453015966, 4981.526754958273, 4994.500549944976, 4329.935050974238, 4589.954100459019, 4599.425071866017, 4612.630989520831, 4622.976885115553, 4828.493008234085, 4870.415550133865, 4893.828715994923, 4896.510348965075, 4927.817323842324, 4728.3380326753595, 4748.928766068442, 4755.714657120584, 4771.761411929459, 4784.354112194809, 4244.236037513278, 4509.706869053501, 4517.277235642281, 4544.341070544819, 4591.931121033121, 3534.6642069003406, 3565.23347480293, 3577.2130131371055, 3585.2751908549167, 3589.353916295092, 4820.951095784348, 4893.853184404474, 4893.951060489349, 5278.392984806643, 5445.26488924006, 5318.606627017934, 5331.0, 5336.226247194213, 5341.919871201857, 5361.597880158925, 5275.261463395204, 5347.449239720438, 5385.27298814655, 5410.918836217538, 5423.430539793265, 5073.771680274471, 5230.137027390438, 5301.628885977944, 5304.602154838325, 5313.574914006947, 5364.30264065669, 5368.32895888014, 5385.946140538545, 5402.459754024566, 5405.918911216257, 5270.341207349082, 5295.894082118413, 5297.894042119213, 5299.417064122867, 5301.496357845998], "value": 3882.7633772411064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.713109183225, 552.6214543038017, 695.3046953046953, 730.0, 786.5949036246334, 12619.684507887307, 13406.128601640887, 13464.394102265409, 13490.190588564694, 13533.593992180226, 11962.700932476671, 12219.694507637314, 12281.754364912696, 12493.063020273494, 12902.0, 762.5119923249139, 774.2412435812906, 781.6951388958311, 781.9335356494705, 787.4055088408244, 790.4901338636575, 793.0681449297082, 794.8291117409756, 796.1282395776644, 797.8284668796208, 834.0241916957144, 838.4801423117646, 843.7510934274404, 846.8137009857852, 847.8050048488851, 829.1873963515728, 835.7952301686096, 837.4305472278847, 837.5100566168799, 841.5750046226677, 603.1826874584918, 606.754264522869, 606.9453749162552, 607.6748939317444, 608.5770389579244, 11387.08903287735, 11581.247218930826, 11600.12999025068, 11627.709307267301, 11650.825237621442, 10906.127509799277, 10998.450077496173, 11170.609028684039, 11346.149038822121, 11429.199956003084, 9049.457032578066, 9171.797418073485, 9211.677591284273, 9355.859662105075, 9470.715878523655, 3264.689854463822, 3323.3187196624635, 3368.831558422069, 3370.5449764282, 3435.587729472479, 52849.207261891104, 54456.727716361165, 54489.72755136199, 54666.72666636681, 54891.17663235054, 9758.365706229073, 9867.506624668738, 9908.653197138066, 9914.80170396588, 10049.59801607942, 16878.66242675164, 17934.19296131677, 18220.90889545544, 18315.816841831678, 18318.26726930908, 6972.686229119702, 7252.746153884589, 7258.455615828834, 7409.073865766779, 7525.6989720410575, 3754.662080412776, 3772.641599048086, 3827.655511004023, 3867.903302417462, 3944.822482988215, 2850.144956513038, 2943.470175368411, 2946.3076177098364, 2969.4209629122547, 2979.61265035544, 490.91899836526574, 503.0969409909222, 512.4747134187488, 513.5480776916289, 520.5575261028172, 581.3982528083413, 593.3265743381294, 624.9750009999549, 630.2846269484169, 632.1466020871878, 7628.427867909929, 7892.684292628231, 7959.761207163794, 8053.1946805319, 8352.039515455679, 599.409581562161, 624.7875722254364, 624.9812505624839, 636.0427556527396, 636.3000699230809, 3783.7162212834146, 3795.221979494197, 3803.6386543278345, 3922.1371298314325, 3963.4451176835264, 88628.11371886327, 89928.0, 90114.0, 93056.53471732598, 93465.53267233756, 80085.59957200177, 81137.59431202806, 81615.0, 82318.58840705758, 83508.0, 45186.32220516695, 46686.29970550445, 59122.0, 66398.99999999904, 71073.2892671077, 7207.207207207098, 7262.527935684164, 7306.465642215195, 7498.512596681198, 7534.773956781305, 43034.35448468338, 43269.567304327815, 43984.0, 44354.0, 44547.55452445434, 54268.45731542792, 54270.0, 63697.363026369145, 63907.0, 64659.353406465336, 10619.0, 10878.673639790819, 11339.433028348714, 11454.427278636202, 11610.361430121087, 11410.885891140982, 12136.33250171249, 12458.127931045103, 12733.55432559856, 12738.235705857678, 10665.146788257076, 11192.440377980905, 11301.830472542753, 11671.76656466883, 13151.0, 11051.778964420828, 11353.659390218307, 11466.885331146581, 11585.536578537101, 11635.941820290844, 10628.415437150721, 10837.512311946139, 10883.891161088604, 10885.727856803644, 11649.534018639159, 9446.149846513847, 9511.286653500876, 9585.28544161005, 9778.9022109778, 9995.70012899614, 9926.801463970825, 10081.798364032531, 10178.236632252463, 10230.846537301797, 10235.385876847413], "value": 6371.769039249885, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 109.0, 116.0, 115.0, 113.0, 114.0, 112.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 157.0, 180.0, 133.0, 161.0, 160.0, 134.0, 188.0, 133.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 173.0, 165.0, 161.0, 166.0, 165.0, 167.0, 162.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 77.0, 155.0, 77.0, 76.0, 76.0, 75.0, 156.0, 78.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 158.0, 87.0, 87.0, 87.0, 135.0, 86.0, 88.0, 136.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 89.0, 85.0, 85.0, 90.0, 84.0, 95.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 132.0, 144.0, 131.0, 130.0, 131.0, 138.0, 146.0, 131.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 171.0, 172.0, 176.0, 170.0, 177.0, 180.0, 173.0, 168.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 71.0, 67.0, 75.0, 67.0, 67.0, 69.0, 67.0, 67.0], "value": 68.6, "unit": "score"}]}]} 03:51:01 INFO - Return code: 0 03:51:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:01 ERROR - # TBPL SUCCESS # 03:51:01 INFO - Running post-action listener: _resource_record_post_action 03:51:01 INFO - ##### 03:51:01 INFO - ##### Finished run-tests step (success) 03:51:01 INFO - ##### 03:51:01 INFO - Running post-run listener: _resource_record_post_run 03:51:01 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 298409984; Read time: 4; Write time: 171024 03:51:01 INFO - TinderboxPrint: CPU usage
13.5% 03:51:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 03:51:01 INFO - TinderboxPrint: I/O write bytes / time
298,409,984 / 171,024 03:51:01 INFO - TinderboxPrint: CPU idle
8,269.9 (86.5%) 03:51:01 INFO - TinderboxPrint: CPU user
1,240.4 (13.0%) 03:51:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1368064; Read time: 0; Write time: 72 03:51:01 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 297041920; Read time: 4; Write time: 170952 03:51:02 INFO - Running post-run listener: _upload_blobber_files 03:51:02 INFO - Blob upload gear active. 03:51:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:02 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 03:51:02 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:02 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:03 INFO - (blobuploader) - INFO - Done attempting. 03:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:07 INFO - (blobuploader) - INFO - Done attempting. 03:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:08 INFO - (blobuploader) - INFO - Done attempting. 03:51:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:08 INFO - Return code: 0 03:51:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7d9765f66ed266c5ca3c83f66f1c0b6eaedb90ee82549b530db8453c975b3b29c5b574676a51cb6584c14bc0e86e54e3a2649c758a33cebdd443329c75b4748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18473c02c9a4a2d8c7911a408831f43326570a7a7cb442fb9f3748e1f0546a013a431a6452a8fe9ec195888beddd03c944adb62d0bd55956ed57057b14156d4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4984943600498700edb49807da056ede2f196b4cf333303c742322727d2484c67c0fd17cf23826a4694683f1a330eb61fa3e340b3a2c9f16012ea8175dce511"} 03:51:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:08 INFO - Contents: 03:51:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7d9765f66ed266c5ca3c83f66f1c0b6eaedb90ee82549b530db8453c975b3b29c5b574676a51cb6584c14bc0e86e54e3a2649c758a33cebdd443329c75b4748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18473c02c9a4a2d8c7911a408831f43326570a7a7cb442fb9f3748e1f0546a013a431a6452a8fe9ec195888beddd03c944adb62d0bd55956ed57057b14156d4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4984943600498700edb49807da056ede2f196b4cf333303c742322727d2484c67c0fd17cf23826a4694683f1a330eb61fa3e340b3a2c9f16012ea8175dce511"} 03:51:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:08 INFO - Copying logs to upload dir... 03:51:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.674749 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 03:51:08.366570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:08.369980) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7d9765f66ed266c5ca3c83f66f1c0b6eaedb90ee82549b530db8453c975b3b29c5b574676a51cb6584c14bc0e86e54e3a2649c758a33cebdd443329c75b4748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18473c02c9a4a2d8c7911a408831f43326570a7a7cb442fb9f3748e1f0546a013a431a6452a8fe9ec195888beddd03c944adb62d0bd55956ed57057b14156d4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4984943600498700edb49807da056ede2f196b4cf333303c742322727d2484c67c0fd17cf23826a4694683f1a330eb61fa3e340b3a2c9f16012ea8175dce511"} build_url:https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7d9765f66ed266c5ca3c83f66f1c0b6eaedb90ee82549b530db8453c975b3b29c5b574676a51cb6584c14bc0e86e54e3a2649c758a33cebdd443329c75b4748", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18473c02c9a4a2d8c7911a408831f43326570a7a7cb442fb9f3748e1f0546a013a431a6452a8fe9ec195888beddd03c944adb62d0bd55956ed57057b14156d4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4984943600498700edb49807da056ede2f196b4cf333303c742322727d2484c67c0fd17cf23826a4694683f1a330eb61fa3e340b3a2c9f16012ea8175dce511"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:08.396006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:08.396380) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466764208.878619-920762083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004358 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:08.478547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:51:08.478872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:51:08.479166) ========= ========= Total master_lag: 0.17 =========