builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1464791108.5 results: success (0) buildid: 20160601060544 builduid: 96bf6103b1444caf9290d603e8ac23f7 revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.496347) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.497050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.497558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.514092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.514659) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:25:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-06-01 07:25:08 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086731 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.628320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.628842) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:08.680768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:25:08.681353) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --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 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:25:08,912 truncating revision to first 12 chars 2016-06-01 07:25:08,913 Setting DEBUG logging. 2016-06-01 07:25:08,913 attempt 1/10 2016-06-01 07:25:08,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78e2125dfb6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:25:10,349 unpacking tar archive at: mozilla-central-78e2125dfb6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.776702 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:25:10.472391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:10.472730) ========= script_repo_revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:10.473115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:10.473381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:25:10.484021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-01 07:25:10.484346) ========= /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=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:10 INFO - MultiFileLogger online at 20160601 07:25:10 in /builds/slave/test 07:25:10 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 07:25:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:10 INFO - {'append_to_log': False, 07:25:10 INFO - 'base_work_dir': '/builds/slave/test', 07:25:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:10 INFO - 'branch': 'Firefox-Non-PGO', 07:25:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:10 INFO - 'config_files': ('talos/linux_config.py',), 07:25:10 INFO - 'default_actions': ('clobber', 07:25:10 INFO - 'read-buildbot-config', 07:25:10 INFO - 'download-and-extract', 07:25:10 INFO - 'populate-webroot', 07:25:10 INFO - 'create-virtualenv', 07:25:10 INFO - 'install', 07:25:10 INFO - 'run-tests'), 07:25:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:10 INFO - 'download_minidump_stackwalk': True, 07:25:10 INFO - 'download_symbols': 'ondemand', 07:25:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:10 INFO - 'installer_path': 'installer.exe', 07:25:10 INFO - 'log_level': 'info', 07:25:10 INFO - 'log_name': 'talos', 07:25:10 INFO - 'log_to_console': True, 07:25:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:10 INFO - 'opt_config_files': (), 07:25:10 INFO - 'pip_index': False, 07:25:10 INFO - 'sps_profile': False, 07:25:10 INFO - 'sps_profile_interval': 0, 07:25:10 INFO - 'suite': 'dromaeojs-e10s', 07:25:10 INFO - 'system_bits': '32', 07:25:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:10 INFO - 'title': 'talos-linux64-ix-054', 07:25:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:10 INFO - 'use_talos_json': True, 07:25:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:10 INFO - 'work_dir': 'build'} 07:25:10 INFO - ##### 07:25:10 INFO - ##### Running clobber step. 07:25:10 INFO - ##### 07:25:10 INFO - Running pre-action listener: _resource_record_pre_action 07:25:10 INFO - Running main action method: clobber 07:25:10 INFO - rmtree: /builds/slave/test/build 07:25:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:11 INFO - Running post-action listener: _resource_record_post_action 07:25:11 INFO - ##### 07:25:11 INFO - ##### Finished clobber step (success) 07:25:11 INFO - ##### 07:25:11 INFO - ##### 07:25:11 INFO - ##### Running read-buildbot-config step. 07:25:11 INFO - ##### 07:25:11 INFO - Running pre-action listener: _resource_record_pre_action 07:25:11 INFO - Running main action method: read_buildbot_config 07:25:11 INFO - Using buildbot properties: 07:25:11 INFO - { 07:25:11 INFO - "project": "", 07:25:11 INFO - "product": "firefox", 07:25:11 INFO - "script_repo_revision": "production", 07:25:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:25:11 INFO - "repository": "", 07:25:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:25:11 INFO - "buildid": "20160601060544", 07:25:11 INFO - "pgo_build": "False", 07:25:11 INFO - "basedir": "/builds/slave/test", 07:25:11 INFO - "buildnumber": 74, 07:25:11 INFO - "slavename": "talos-linux64-ix-054", 07:25:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:25:11 INFO - "platform": "ubuntu64_hw", 07:25:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:25:11 INFO - "branch": "mozilla-central", 07:25:11 INFO - "repo_path": "mozilla-central", 07:25:11 INFO - "revision": "78e2125dfb6b02cdbab73a30c54bb4dc19aa310a", 07:25:11 INFO - "stage_platform": "linux64", 07:25:11 INFO - "builduid": "96bf6103b1444caf9290d603e8ac23f7", 07:25:11 INFO - "slavebuilddir": "test" 07:25:11 INFO - } 07:25:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:25:11 INFO - Running post-action listener: _resource_record_post_action 07:25:11 INFO - ##### 07:25:11 INFO - ##### Finished read-buildbot-config step (success) 07:25:11 INFO - ##### 07:25:11 INFO - ##### 07:25:11 INFO - ##### Running download-and-extract step. 07:25:11 INFO - ##### 07:25:11 INFO - Running pre-action listener: _resource_record_pre_action 07:25:11 INFO - Running main action method: download_and_extract 07:25:11 INFO - mkdir: /builds/slave/test/build/tests 07:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:11 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:25:13 INFO - Downloaded 1361 bytes. 07:25:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:13 INFO - Using the following test package requirements: 07:25:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'jsshell-linux-x86_64.zip'], 07:25:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:13 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')]} 07:25:13 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:25:14 INFO - Downloaded 22840484 bytes. 07:25:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:25:15 INFO - Return code: 0 07:25:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:15 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:25:16 INFO - Downloaded 22840484 bytes. 07:25:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:25:18 INFO - Return code: 0 07:25:18 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')]} 07:25:18 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:25:19 INFO - Downloaded 10834055 bytes. 07:25:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:25:19 INFO - Return code: 0 07:25: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')]} 07:25:19 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:25:24 INFO - Downloaded 55033936 bytes. 07:25:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:24 INFO - mkdir: /builds/slave/test/properties 07:25:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:24 INFO - Contents: 07:25:24 INFO - build_url:https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:25 INFO - Running post-action listener: _resource_record_post_action 07:25:25 INFO - Running post-action listener: set_extra_try_arguments 07:25:25 INFO - ##### 07:25:25 INFO - ##### Finished download-and-extract step (success) 07:25:25 INFO - ##### 07:25:25 INFO - ##### 07:25:25 INFO - ##### Running populate-webroot step. 07:25:25 INFO - ##### 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: populate_webroot 07:25:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:25 INFO - '--tppagecycles', 07:25:25 INFO - '7'], 07:25:25 INFO - 'tests': ['tsvgm']}}, 07:25:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['damp', 'tps']}, 07:25:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'tests': ['damp', 'tps']}, 07:25:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['dromaeo_dom']}, 07:25:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['a11yr', 07:25:25 INFO - 'ts_paint', 07:25:25 INFO - 'tpaint', 07:25:25 INFO - 'sessionrestore', 07:25:25 INFO - 'sessionrestore_no_auto_restore', 07:25:25 INFO - 'tabpaint']}, 07:25:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['tsvgx', 07:25:25 INFO - 'tsvgr_opacity', 07:25:25 INFO - 'tart', 07:25:25 INFO - 'tscrollx', 07:25:25 INFO - 'cart']}, 07:25:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:25 INFO - 'tsvgr_opacity', 07:25:25 INFO - 'tart', 07:25:25 INFO - 'tscrollx', 07:25:25 INFO - 'cart']}, 07:25:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'talos_options': ['--disable-e10s'], 07:25:25 INFO - 'tests': ['tp5o']}, 07:25:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'tests': ['tp5o']}, 07:25:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'talos_options': ['--disable-e10s', 07:25:25 INFO - '--xperf_path', 07:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:25 INFO - 'tests': ['tp5n']}, 07:25:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:25 INFO - 'talos_options': ['--xperf_path', 07:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:25 INFO - 'tests': ['tp5n']}}, 07:25:25 INFO - 'talos.zip': {'path': '', 07:25:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:25 INFO - Running post-action listener: _resource_record_post_action 07:25:25 INFO - ##### 07:25:25 INFO - ##### Finished populate-webroot step (success) 07:25:25 INFO - ##### 07:25:25 INFO - ##### 07:25:25 INFO - ##### Running create-virtualenv step. 07:25:25 INFO - ##### 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: create_virtualenv 07:25:25 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:25 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 07:25:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:25 INFO - Using real prefix '/usr' 07:25:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:27 INFO - Installing pip.................done. 07:25:27 INFO - Return code: 0 07:25:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:27 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:27 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 07:25:27 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 07:25:27 INFO - Using env: {'DISPLAY': ':0', 07:25:27 INFO - 'HOME': '/home/cltbld', 07:25:27 INFO - 'LANG': 'en_US.UTF-8', 07:25:27 INFO - 'LANGUAGE': 'en_US:en', 07:25:27 INFO - 'LOGNAME': 'cltbld', 07:25:27 INFO - 'MAIL': '/var/mail/cltbld', 07:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:27 INFO - 'MOZ_NO_REMOTE': '1', 07:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:27 INFO - 'NO_EM_RESTART': '1', 07:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:27 INFO - 'PWD': '/builds/slave/test', 07:25:27 INFO - 'SHELL': '/bin/bash', 07:25:27 INFO - 'SHLVL': '1', 07:25:27 INFO - 'TERM': 'linux', 07:25:27 INFO - 'TMOUT': '86400', 07:25:27 INFO - 'USER': 'cltbld', 07:25:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:27 INFO - '_': '/tools/buildbot/bin/python'} 07:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:28 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 07:25:28 INFO - Cleaning up... 07:25:28 INFO - Return code: 0 07:25:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:28 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:28 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 07:25:28 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 07:25:28 INFO - Using env: {'DISPLAY': ':0', 07:25:28 INFO - 'HOME': '/home/cltbld', 07:25:28 INFO - 'LANG': 'en_US.UTF-8', 07:25:28 INFO - 'LANGUAGE': 'en_US:en', 07:25:28 INFO - 'LOGNAME': 'cltbld', 07:25:28 INFO - 'MAIL': '/var/mail/cltbld', 07:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:28 INFO - 'MOZ_NO_REMOTE': '1', 07:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:28 INFO - 'NO_EM_RESTART': '1', 07:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:28 INFO - 'PWD': '/builds/slave/test', 07:25:28 INFO - 'SHELL': '/bin/bash', 07:25:28 INFO - 'SHLVL': '1', 07:25:28 INFO - 'TERM': 'linux', 07:25:28 INFO - 'TMOUT': '86400', 07:25:28 INFO - 'USER': 'cltbld', 07:25:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:28 INFO - '_': '/tools/buildbot/bin/python'} 07:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:28 INFO - Downloading/unpacking psutil>=3.1.1 07:25:28 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 07:25:28 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 07:25:28 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 07:25:28 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 07:25:28 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 07:25:28 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 07:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:30 INFO - Installing collected packages: psutil 07:25:30 INFO - Running setup.py install for psutil 07:25:30 INFO - building 'psutil._psutil_linux' extension 07:25:30 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 07:25:30 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 07:25:30 INFO - building 'psutil._psutil_posix' extension 07:25:30 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 07:25:30 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 07:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:31 INFO - Successfully installed psutil 07:25:31 INFO - Cleaning up... 07:25:31 INFO - Return code: 0 07:25:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:31 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:31 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 07:25:31 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 07:25:31 INFO - Using env: {'DISPLAY': ':0', 07:25:31 INFO - 'HOME': '/home/cltbld', 07:25:31 INFO - 'LANG': 'en_US.UTF-8', 07:25:31 INFO - 'LANGUAGE': 'en_US:en', 07:25:31 INFO - 'LOGNAME': 'cltbld', 07:25:31 INFO - 'MAIL': '/var/mail/cltbld', 07:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:31 INFO - 'MOZ_NO_REMOTE': '1', 07:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:31 INFO - 'NO_EM_RESTART': '1', 07:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:31 INFO - 'PWD': '/builds/slave/test', 07:25:31 INFO - 'SHELL': '/bin/bash', 07:25:31 INFO - 'SHLVL': '1', 07:25:31 INFO - 'TERM': 'linux', 07:25:31 INFO - 'TMOUT': '86400', 07:25:31 INFO - 'USER': 'cltbld', 07:25:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:31 INFO - '_': '/tools/buildbot/bin/python'} 07:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:25:34 INFO - Installing collected packages: mozsystemmonitor 07:25:34 INFO - Running setup.py install for mozsystemmonitor 07:25:34 INFO - Successfully installed mozsystemmonitor 07:25:34 INFO - Cleaning up... 07:25:34 INFO - Return code: 0 07:25:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:34 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')]} 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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')]} 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:34 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 07:25:34 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 07:25:34 INFO - Using env: {'DISPLAY': ':0', 07:25:34 INFO - 'HOME': '/home/cltbld', 07:25:34 INFO - 'LANG': 'en_US.UTF-8', 07:25:34 INFO - 'LANGUAGE': 'en_US:en', 07:25:34 INFO - 'LOGNAME': 'cltbld', 07:25:34 INFO - 'MAIL': '/var/mail/cltbld', 07:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:34 INFO - 'MOZ_NO_REMOTE': '1', 07:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:34 INFO - 'NO_EM_RESTART': '1', 07:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:34 INFO - 'PWD': '/builds/slave/test', 07:25:34 INFO - 'SHELL': '/bin/bash', 07:25:34 INFO - 'SHLVL': '1', 07:25:34 INFO - 'TERM': 'linux', 07:25:34 INFO - 'TMOUT': '86400', 07:25:34 INFO - 'USER': 'cltbld', 07:25:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:34 INFO - '_': '/tools/buildbot/bin/python'} 07:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:34 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 07:25:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:37 INFO - Downloading docopt-0.6.1.tar.gz 07:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:37 INFO - Running setup.py install for blobuploader 07:25:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:37 INFO - Running setup.py install for requests 07:25:38 INFO - Running setup.py install for docopt 07:25:38 INFO - Successfully installed blobuploader requests docopt 07:25:38 INFO - Cleaning up... 07:25:38 INFO - Return code: 0 07:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:38 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')]} 07:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:38 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')]} 07:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:38 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:38 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 07:25:38 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 07:25:38 INFO - Using env: {'DISPLAY': ':0', 07:25:38 INFO - 'HOME': '/home/cltbld', 07:25:38 INFO - 'LANG': 'en_US.UTF-8', 07:25:38 INFO - 'LANGUAGE': 'en_US:en', 07:25:38 INFO - 'LOGNAME': 'cltbld', 07:25:38 INFO - 'MAIL': '/var/mail/cltbld', 07:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:38 INFO - 'MOZ_NO_REMOTE': '1', 07:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:38 INFO - 'NO_EM_RESTART': '1', 07:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:38 INFO - 'PWD': '/builds/slave/test', 07:25:38 INFO - 'SHELL': '/bin/bash', 07:25:38 INFO - 'SHLVL': '1', 07:25:38 INFO - 'TERM': 'linux', 07:25:38 INFO - 'TMOUT': '86400', 07:25:38 INFO - 'USER': 'cltbld', 07:25:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:38 INFO - '_': '/tools/buildbot/bin/python'} 07:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:38 INFO - Running setup.py (path:/tmp/pip-LjSakC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:38 INFO - Running setup.py (path:/tmp/pip-OT9OSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:38 INFO - Running setup.py (path:/tmp/pip-OLQusp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:38 INFO - Running setup.py (path:/tmp/pip-tV_Khp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:38 INFO - Running setup.py (path:/tmp/pip-JAAONA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:38 INFO - Running setup.py (path:/tmp/pip-ebUjOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:39 INFO - Running setup.py (path:/tmp/pip-dEwHgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:39 INFO - Running setup.py (path:/tmp/pip-x6NxaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:39 INFO - Running setup.py (path:/tmp/pip-m7pGsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:39 INFO - Running setup.py (path:/tmp/pip-pmxcX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:39 INFO - Running setup.py (path:/tmp/pip-gcjQ1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:39 INFO - Running setup.py (path:/tmp/pip-8ZqbLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:39 INFO - Running setup.py (path:/tmp/pip-sZg6My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:39 INFO - Running setup.py (path:/tmp/pip-s4mNWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:39 INFO - Running setup.py (path:/tmp/pip-QV1XrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:39 INFO - Running setup.py (path:/tmp/pip-W_syFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:39 INFO - Running setup.py (path:/tmp/pip-AgJEeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:39 INFO - Running setup.py install for manifestparser 07:25:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:39 INFO - Running setup.py install for mozcrash 07:25:40 INFO - Running setup.py install for mozdebug 07:25:40 INFO - Running setup.py install for mozdevice 07:25:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for mozfile 07:25:40 INFO - Running setup.py install for mozhttpd 07:25:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for mozinfo 07:25:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for mozInstall 07:25:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for mozleak 07:25:40 INFO - Running setup.py install for mozlog 07:25:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for moznetwork 07:25:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:40 INFO - Running setup.py install for mozprocess 07:25:41 INFO - Running setup.py install for mozprofile 07:25:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:41 INFO - Running setup.py install for mozrunner 07:25:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:41 INFO - Running setup.py install for mozscreenshot 07:25:41 INFO - Running setup.py install for moztest 07:25:41 INFO - Running setup.py install for mozversion 07:25:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:41 INFO - Cleaning up... 07:25:41 INFO - Return code: 0 07:25:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:41 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:41 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 07:25:41 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 07:25:41 INFO - Using env: {'DISPLAY': ':0', 07:25:41 INFO - 'HOME': '/home/cltbld', 07:25:41 INFO - 'LANG': 'en_US.UTF-8', 07:25:41 INFO - 'LANGUAGE': 'en_US:en', 07:25:41 INFO - 'LOGNAME': 'cltbld', 07:25:41 INFO - 'MAIL': '/var/mail/cltbld', 07:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:41 INFO - 'MOZ_NO_REMOTE': '1', 07:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:41 INFO - 'NO_EM_RESTART': '1', 07:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:41 INFO - 'PWD': '/builds/slave/test', 07:25:41 INFO - 'SHELL': '/bin/bash', 07:25:41 INFO - 'SHLVL': '1', 07:25:41 INFO - 'TERM': 'linux', 07:25:41 INFO - 'TMOUT': '86400', 07:25:41 INFO - 'USER': 'cltbld', 07:25:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:41 INFO - '_': '/tools/buildbot/bin/python'} 07:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:41 INFO - Running setup.py (path:/tmp/pip-vlsp2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:41 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)) 07:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:41 INFO - Running setup.py (path:/tmp/pip-PiKOmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:42 INFO - Running setup.py (path:/tmp/pip-s105VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:42 INFO - Running setup.py (path:/tmp/pip-csjG9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:42 INFO - Running setup.py (path:/tmp/pip-Lt8oIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:42 INFO - Running setup.py (path:/tmp/pip-Dqlvt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:42 INFO - Running setup.py (path:/tmp/pip-RKlAX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:42 INFO - Running setup.py (path:/tmp/pip-_lSS7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:42 INFO - Running setup.py (path:/tmp/pip-GZwJDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:42 INFO - Running setup.py (path:/tmp/pip-VCHALc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:42 INFO - Running setup.py (path:/tmp/pip-Lu5y05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:42 INFO - Running setup.py (path:/tmp/pip-V2JQg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:42 INFO - Running setup.py (path:/tmp/pip-w4RwYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:42 INFO - Running setup.py (path:/tmp/pip-vynuCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:42 INFO - Running setup.py (path:/tmp/pip-MYfYKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:42 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)) 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:42 INFO - Running setup.py (path:/tmp/pip-UYzeYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:43 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)) 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:43 INFO - Running setup.py (path:/tmp/pip-b5he4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:43 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)) 07:25:43 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)) 07:25:43 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)) 07:25:43 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)) 07:25:43 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)) 07:25:43 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)) 07:25:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:44 INFO - Downloading blessings-1.6.tar.gz 07:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:45 INFO - Installing collected packages: blessings 07:25:45 INFO - Running setup.py install for blessings 07:25:45 INFO - Successfully installed blessings 07:25:45 INFO - Cleaning up... 07:25:45 INFO - Return code: 0 07:25:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:45 INFO - Reading from file tmpfile_stdout 07:25:45 INFO - Current package versions: 07:25:45 INFO - argparse == 1.2.1 07:25:45 INFO - blessings == 1.6 07:25:45 INFO - blobuploader == 1.2.4 07:25:45 INFO - docopt == 0.6.1 07:25:45 INFO - manifestparser == 1.1 07:25:45 INFO - mozInstall == 1.12 07:25:45 INFO - mozcrash == 0.17 07:25:45 INFO - mozdebug == 0.1 07:25:45 INFO - mozdevice == 0.48 07:25:45 INFO - mozfile == 1.2 07:25:45 INFO - mozhttpd == 0.7 07:25:45 INFO - mozinfo == 0.9 07:25:45 INFO - mozleak == 0.1 07:25:45 INFO - mozlog == 3.2 07:25:45 INFO - moznetwork == 0.27 07:25:45 INFO - mozprocess == 0.22 07:25:45 INFO - mozprofile == 0.28 07:25:45 INFO - mozrunner == 6.11 07:25:45 INFO - mozscreenshot == 0.1 07:25:45 INFO - mozsystemmonitor == 0.3 07:25:45 INFO - moztest == 0.7 07:25:45 INFO - mozversion == 1.4 07:25:45 INFO - psutil == 3.1.1 07:25:45 INFO - requests == 1.2.3 07:25:45 INFO - wsgiref == 0.1.2 07:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 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 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:45 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 07:25:45 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 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 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)) 07:25:45 INFO - Cleaning up... 07:25:45 INFO - Return code: 0 07:25:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 INFO - Downloading/unpacking jsonschema 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:47 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25:47 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 07:25:47 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 07:25:47 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 07:25:47 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 07:25:47 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 07:25:47 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 07:25:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:48 INFO - warning: no files found matching '*.txt' 07:25:48 INFO - no previously-included directories found matching 'build' 07:25:48 INFO - no previously-included directories found matching 'dist' 07:25:48 INFO - no previously-included directories found matching '.git*' 07:25:48 INFO - Installing collected packages: jsonschema, functools32 07:25:48 INFO - Running setup.py install for functools32 07:25:48 INFO - warning: no files found matching '*.txt' 07:25:48 INFO - no previously-included directories found matching 'build' 07:25:48 INFO - no previously-included directories found matching 'dist' 07:25:48 INFO - no previously-included directories found matching '.git*' 07:25:48 INFO - Successfully installed jsonschema functools32 07:25:48 INFO - Cleaning up... 07:25:48 INFO - Return code: 0 07:25:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f3fee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1603770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', '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 07:25: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', 'flake8'] in /builds/slave/test/build 07:25: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 flake8 07:25:48 INFO - Using env: {'DISPLAY': ':0', 07:25:48 INFO - 'HOME': '/home/cltbld', 07:25:48 INFO - 'LANG': 'en_US.UTF-8', 07:25:48 INFO - 'LANGUAGE': 'en_US:en', 07:25:48 INFO - 'LOGNAME': 'cltbld', 07:25:48 INFO - 'MAIL': '/var/mail/cltbld', 07:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:48 INFO - 'MOZ_NO_REMOTE': '1', 07:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:48 INFO - 'NO_EM_RESTART': '1', 07:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:48 INFO - 'PWD': '/builds/slave/test', 07:25:48 INFO - 'SHELL': '/bin/bash', 07:25:48 INFO - 'SHLVL': '1', 07:25:48 INFO - 'TERM': 'linux', 07:25:48 INFO - 'TMOUT': '86400', 07:25:48 INFO - 'USER': 'cltbld', 07:25:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:48 INFO - '_': '/tools/buildbot/bin/python'} 07:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:48 INFO - Downloading/unpacking flake8 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:51 INFO - no previously-included directories found matching 'docs/_build' 07:25:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:51 INFO - Running setup.py install for pep8 07:25:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:51 INFO - no previously-included directories found matching 'docs/_build' 07:25:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:25:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:51 INFO - Cleaning up... 07:25:51 INFO - Return code: 0 07:25:51 INFO - Running post-action listener: _resource_record_post_action 07:25:51 INFO - Running post-action listener: _start_resource_monitoring 07:25:51 INFO - Starting resource monitoring. 07:25:51 INFO - ##### 07:25:51 INFO - ##### Finished create-virtualenv step (success) 07:25:51 INFO - ##### 07:25:51 INFO - ##### 07:25:51 INFO - ##### Running install step. 07:25:51 INFO - ##### 07:25:51 INFO - Running pre-action listener: _resource_record_pre_action 07:25:51 INFO - Running main action method: install 07:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:51 INFO - Reading from file tmpfile_stdout 07:25:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:51 INFO - Reading from file tmpfile_stdout 07:25:51 INFO - Output received: 07:25:51 INFO - Usage: mozinstall [options] installer 07:25:51 INFO - Options: 07:25:51 INFO - -h, --help show this help message and exit 07:25:51 INFO - -d DEST, --destination=DEST 07:25:51 INFO - Directory to install application into. [default: 07:25:51 INFO - "/builds/slave/test"] 07:25:51 INFO - --app=APP Application being installed. [default: firefox] 07:25:51 INFO - mkdir: /builds/slave/test/build/application 07:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:26:07 INFO - Reading from file tmpfile_stdout 07:26:07 INFO - Output received: 07:26:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:07 INFO - Running post-action listener: _resource_record_post_action 07:26:07 INFO - ##### 07:26:07 INFO - ##### Finished install step (success) 07:26:07 INFO - ##### 07:26:07 INFO - ##### 07:26:07 INFO - ##### Running run-tests step. 07:26:07 INFO - ##### 07:26:07 INFO - Running pre-action listener: _resource_record_pre_action 07:26:07 INFO - Running main action method: run_tests 07:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:07 INFO - Python 2.7.3 07:26:07 INFO - Return code: 0 07:26:07 INFO - grabbing minidump binary from tooltool 07:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:07 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 0x16929c0>, '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 0x16938c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1693d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:07 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 07:26:07 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 07:26:07 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 07:26:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:07 INFO - Return code: 0 07:26:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:08 INFO - Return code: 0 07:26:08 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:26:08 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:26:08 INFO - Using env: {'DISPLAY': ':0', 07:26:08 INFO - 'HOME': '/home/cltbld', 07:26:08 INFO - 'LANG': 'en_US.UTF-8', 07:26:08 INFO - 'LANGUAGE': 'en_US:en', 07:26:08 INFO - 'LOGNAME': 'cltbld', 07:26:08 INFO - 'MAIL': '/var/mail/cltbld', 07:26:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:08 INFO - 'MOZ_NO_REMOTE': '1', 07:26:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:08 INFO - 'NO_EM_RESTART': '1', 07:26:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:08 INFO - 'PWD': '/builds/slave/test', 07:26:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:08 INFO - 'SHELL': '/bin/bash', 07:26:08 INFO - 'SHLVL': '1', 07:26:08 INFO - 'TERM': 'linux', 07:26:08 INFO - 'TMOUT': '86400', 07:26:08 INFO - 'USER': 'cltbld', 07:26:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652', 07:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:08 INFO - '_': '/tools/buildbot/bin/python'} 07:26:08 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:26:08 INFO - mozversion application_buildid: 20160601060544 07:26:08 INFO - mozversion application_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 07:26:08 INFO - mozversion application_display_name: Nightly 07:26:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:08 INFO - mozversion application_name: Firefox 07:26:08 INFO - mozversion application_remotingname: firefox 07:26:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:08 INFO - mozversion application_vendor: Mozilla 07:26:08 INFO - mozversion application_version: 49.0a1 07:26:08 INFO - mozversion platform_buildid: 20160601060544 07:26:08 INFO - mozversion platform_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 07:26:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:08 INFO - mozversion platform_version: 49.0a1 07:26:08 INFO - using testdate: 1464791168 07:26:08 INFO - actual date: 1464791168 07:26:08 INFO - starting webserver on 'localhost:39376' 07:26:08 INFO - SUITE-START | Running 2 tests 07:26:08 INFO - TEST-START | dromaeo_css 07:26:08 INFO - operating with platform_type : linux_ 07:26:08 INFO - Initialising browser for dromaeo_css test... 07:26:08 INFO - TEST-INFO | started process 330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIP7boW/profile http://localhost:39376/getInfo.html) 07:26:13 INFO - PROCESS | 330 | __metrics Screen width/height:1600/1200 07:26:13 INFO - PROCESS | 330 | colorDepth:24 07:26:13 INFO - PROCESS | 330 | Browser inner width/height: 1024/697 07:26:13 INFO - PROCESS | 330 | __metrics 07:26:14 ERROR - PROCESS | 330 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:26:15 INFO - TEST-INFO | 330: exit 0 07:26:15 INFO - Browser initialized. 07:26:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:15 INFO - TEST-INFO | started process 453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIP7boW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:27 INFO - PROCESS | 453 | RSS: Main: 167550976 07:26:27 INFO - PROCESS | 453 | 07:27:17 INFO - PROCESS | 453 | 1464791237154 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] 07:29:28 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39376/tests/dromaeo/cssquery-ext.html) 07:29:29 INFO - PROCESS | 453 | RSS: Main: 170577920 07:29:29 INFO - PROCESS | 453 | 07:32:32 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-ext.html (next: http://localhost:39376/tests/dromaeo/cssquery-jquery.html) 07:32:32 INFO - PROCESS | 453 | RSS: Main: 169910272 07:32:32 INFO - PROCESS | 453 | 07:35:34 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39376/tests/dromaeo/cssquery-mootools.html) 07:35:35 INFO - PROCESS | 453 | RSS: Main: 171241472 07:35:35 INFO - PROCESS | 453 | 07:38:37 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39376/tests/dromaeo/cssquery-prototype.html) 07:38:37 INFO - PROCESS | 453 | RSS: Main: 168329216 07:38:37 INFO - PROCESS | 453 | 07:41:40 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39376/tests/dromaeo/cssquery-yui.html) 07:41:41 INFO - PROCESS | 453 | RSS: Main: 169648128 07:41:41 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39376/tests/dromaeo/cssquery-yui.html (next: http://localhost:39376/tests/dromaeo/cssquery-dojo.html) 07:44:43 INFO - PROCESS | 453 | RSS: Main: 171552768 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | __start_tp_report 07:44:43 INFO - PROCESS | 453 | _x_x_mozilla_page_load 07:44:43 INFO - PROCESS | 453 | _x_x_mozilla_page_load_details 07:44:43 INFO - PROCESS | 453 | |i|pagename|runs| 07:44:43 INFO - PROCESS | 453 | |0;dojo.html;2631.763141317281;2665.5735082386823;2716.022231996481;2717.2391730315517;2725.563909774438;4635.7913893874775;4673.556012178842;4684.297355396692;4752.453467851198;4802.975985120078;4582.1064892346;4694.413198350207;4736.857894263169;4750.7862146203415;4755.762211889409;4292.120115376348;4320.09278051608;4392.648588112959;4433.31283651033;4437.822487100512;4128.723108124225;4448.599626033656;4466.665000124987;4495.213337665896;4495.595396414322;4277.422547956017;4281.079567892887;4332.1985432695055;4387.627051700593;4462.107578484316;4307.095509942885;4310.913781724348;4313.439252897135;4326.156399502099;4358.063016451478;4336.111097225062;4348.195583817004;4355.259605866979;4362.389265502832;4401.943533551925;4580.839670611513;4619.653525985565;4626.467956185048;4635.7218566886095;4676.7427791471455;5018.84943451697;5022.372203474566;5043.394792624908;5062.873428164288;5111.284420181178;4930.80276788928;5041.798328066873;5090.745462726849;5093;5145.228215767665;4685.461171965199;4722.079194557028;4726.054789042137;4729.527047295243;4732.124556956974;5170.689758614495;5197.62747345856;5198.532132108128;5202.479752024768;5262.657927234794;4849.975750121297;4954.430240522314;4957.281194226817;4961.454240033593;5018.146915024455;5040.117979353672;5062.670926389773;5080;5110.744462776846;5121.4878512149235;4899.412070551557;4932.890099727532;4940.505949405031;4989.476105008995;5004.024215278058;4950;4951.455339912607;4968.627352948543;4998.075356059141;5016.347874776328;4159.8960025999595;4201.369794530845;4216.578342165821;4239.342901850218;4292.141571685613;3749.7562658427114;3761.4169803680475;3765.171662234304;3769.264993326275;3803.1062700265416;4298.527162012176;4314.201872653569;4323.697341186087;4330.718503297276;4377.015171586368;4975.328330675385;5073.34046573943;5141.408737995179;5150.768215430315;5154.92267615986;4316.330968699856;4317.438732964694;4320.848770293024;4350.151720414552;4372.584604462571;4526.140033393644;4553.54464553542;4566.817327306937;4567.337736028324;4611.469680986729;4782;4782.234842425195;4824.396950381202;4827.879303017453;4829.444613869309;5053.11570475158;5090.643654944267;5105.821296254613;5107.310513080686;5186.014657215117;4661.394018777537;4805.3512775774825;4815.590674792542;4838.032393521239;4871.48849370811;5008.298838162733;5009.123403404316;5044.041632089891;5051.494850514919;5066.797328106982;5078.898422031465;5131.769070391767;5141.074606570854;5168.638195326291;5168.715720635401;4780.665353425227;4890.193118135468;4964.131277026434;4992.101421744121;4998.475160108136;4785.688930219525;4857.052874689543;4893.412790465167;4942.382202224722;4997.475265097112;4817.421909370898;4825.3485779419325;4830.637702172421;4831.396075490564;4834.564889159992;4847.854564363075;4926.975365123151;4927.507249275044;4937.086638971802;4955.157623204136;4781.880452988703;4827.034593081468;4828.227483602606;4839.95160048395;4844.128056949783 07:44:43 INFO - PROCESS | 453 | |1;ext.html;566.1338152626481;574.7442388137281;584.7690162385857;588.5674029588255;609.5489337889962;35927.64072359279;39991.2001759965;40115.197696046096;40135.799321003426;40142;41210.17579648413;42068.789656051755;42128.36807447883;42169;42279.78860105703;7556.206598307181;7875.527468351888;7879.645415956267;7885.329746971485;7897.210278972086;7747.96126019372;7812.06255249368;7815.452918295721;7898.210178982114;7911.920880791205;7863;7863.095743989428;7916.683332666716;7920.287174154325;7926.960365198195;7798.8440231195345;7841.333486653642;7845.254700803414;7869.173736757615;7880.487768295071;7679.1936846631415;7734.3039126478325;7742;7746.419018573573;7753.185915478906;37477.25045499102;37706.62293377059;37784.244315113545;38087;38112.42831357532;3197.7441804655805;3311.420501412267;3345.631980482145;3353.2119951811305;3709.2025214578725;30196.69803301961;30307.545386819216;30444.695553044407;30712;30813.691863081305;3535.4166562517153;3554.413521768905;3564.6078931317534;3577.8032208228537;3623.420252759572;263684;264812.9999999981;266631;266756;266837;32760.67239327624;33692;55526.444735552934;55736.44263557313;55926.72036639791;35065.824670876485;35347.293054139285;35540.111497212776;35588;35616.109597259754;12896.742065158833;12976.221426714428;12989.545365912149;13024.804627930589;13060.21638701681;11838.052955763518;11962.222455540363;11994.34031128279;12001.879981200076;12020.639380818415;8023.839523209504;8130.065042520067;8145.5927203639585;8163.632636531371;8174.713885013996;3179.856906439216;3182.172635114887;3196.9680303197138;3225.0969728476066;3227.725643320297;866.4757821518017;904.5251243097294;910.1490106750209;923.8568021956607;924.7456949338986;27565.586516202275;28549.429011419656;28613.14160575186;29049.56425653617;29107.126786196448;903.8689390038408;975.4147511493047;986.8569057486624;1012.5797793915442;1026.5431882812227;15269.236538173269;15369.080884374636;15453.690926181413;15509.767353489706;15594.376224950875;384206;386627;387985;389393;389519;50174.74912625414;51095;51304.23043654348;51740.22389664158;51749;1201.2672269915345;1227.4660522672666;1239.5661518468464;1240.5472002719123;1249.2067537113999;27769;28263.576046359733;28861.82519922849;29190.854045729637;29266.122016339545;45340.54659453495;45401.545984539734;45427.54572454233;45458;45907.770461147484;328516;328779;329395;330803;331029;25632.077594180137;25749.871250643628;26179.607305890047;26189.738102619493;26215;43026.569734302255;43343.56656433395;43923.78038109789;44232.33651495294;44691.32963005623;36584;36869.81565092158;37154.44268335923;37609.623903760614;37623.81188094042;36725.26549469049;36768.81615592012;36952.26095478129;37081.62918370782;37323;35541.466877997365;36128.20653831415;36543.45184822177;36600.26799463943;36824;31716;32331.676683232865;33063.83468082644;33271.16822079467;33505;25361.492770144123;25365.239042828744;25711.357216069748;26680.466390672467;28124.437511249253 07:44:43 INFO - PROCESS | 453 | |2;jquery.html;372.4153079664927;383.55890725665483;383.5922165652058;396.6410398589278;401.5201833808598;15188.392464301429;17221.569460763487;17276.568085797862;17546.03496807675;17559.736603950936;16600.25298861551;16846.66306673869;17036.892601980864;17342.739858902096;17350.219240134193;4893.217085266349;5018.272350509174;5084.898302033957;5086.465921078289;5096.261042148886;3692.48305237267;5511.338639363282;5793.102069179284;5809.3609702932645;5911.3201981772;5817.360090390053;5871.647701137924;5872.148538461921;5873.530117590582;5893.7347819348015;5791;5890.528757699417;5893.14549390336;5893.263342082239;5945.197398351233;5137.840228259631;5186.377634683862;5199.558037566811;5211.296474975868;5239.266502689627;20417.79582204174;20566.38300850977;20889.37331880046;20937.26719564823;21040.789592104036;1851.5833937363984;1944.7860735319105;2108.7153234313323;2387.9403014924765;2474.6288056791445;13218.60344189676;13302.201867887958;13383.732325353536;13421.731565368736;13710.725785484334;1727.8444939955339;1750.6586215687946;1775.254393154878;1786.7135662323108;1816.373351193836;66687.66656166737;67647.66176169137;67811;68416.97374539435;68547.65726171338;9341.532923353805;9466.668666596774;9494.905050949403;9646.565904534313;9741.902580974242;12963.611091667264;13049.28228947398;13097.41061652228;13099.148555344063;13150.013748968866;6948.895766563505;7013.579185248901;7040.823979400556;7055.7177712891935;7357.705691772377;6863.627274545111;6918.8962165567555;6923.065386172903;7004.719811207597;7036.753713619999;5933.131063714916;6105.419985101408;6109.327973922865;6132.846678833065;6174.783882564088;1615.668787898478;1704.1479260369815;1830.9908450457663;1838.1032211711258;1844.4651051195003;854.9273311768445;858.914108589136;940.9059094090674;968.651285537206;979.8628192053118;15909.920450397674;16710;16968.23642936071;17347.306107755547;17359.132043397778;892.4065496444921;904.6471875968377;940.4075432477496;955.2358113509165;970.2771435280761;9642.662506812228;9865.901340986642;9881.110700037032;9920.851187232198;9994.250431217688;373132;389013;391054;402251;402880.9855950702;41172.38160494952;41673;66687.66656166785;67387.32612673909;69059;951.0917074194128;956.3401253135314;968.7626531499827;993.6820217530321;1001.7595777013464;15221.847781522487;15223.619409514851;15353.6161595961;15448.691026179638;15543.378264869278;25558.616620751076;32184.03447896567;32192.67807321897;32449.675503244664;32633;41363;42213.045086843624;42492.15015699607;42985;43475.56524434715;7110.6089165094345;7111.111111111111;7232.276772322725;7265.491415600857;7285.089363829521;9504.809903802023;10319.329243599143;10449.582016719247;10590.152787776806;10611.469426528796;9107.544622768703;9122.087791220825;9267.67563135287;9320.95339523298;9473.158052584335;9067.546622668708;9167.679131230641;9225.261979041794;9351;9471.810563788547;9043.231325337158;9090.090990900857;9235.630574777202;9512.619495220113;9605.615775368908;7145.785626431215;7149.428045756431;7290.890636640349;7336.119665640157;7346.265373462825;6962.756303529352;8299.460535065202;8364.079951205242;8934.329925255503;9071.818563628822 07:44:43 INFO - PROCESS | 453 | |3;mootools.html;1385.861413858614;1445.8409574946756;1550.9612259693506;1768.275007247029;1775.1124437781118;7095.503314767969;7733.883991740115;7806.882896756546;8277.91722082779;8312.127226641207;7793.298603125718;8053.355731541477;8090.878636820453;8104.878426823602;8112.188781121885;2167.7615462299173;2219.889005549724;2220.711307530019;2224.3215819175143;2233;2195.4621117826077;2199;2200.515886504966;2202.966955495669;2252.1892118837204;2191.7150770399826;2197.6593627987686;2209.8784566848817;2218.811401030914;2225.087714037245;2116.640171170897;2122.3102491690183;2131.2753663754243;2136.0708091980036;2139.2512620582747;2110.8733475991335;2123.8088572028437;2130.7017017617545;2137.9144834206613;2138.134055707441;7995.280424761741;8010.479318844256;8024.398170137263;8049.798755031171;8054.919450805475;4545.386372839657;4600.5169457207185;4737.028909073631;4740.051989602093;4753.714777113384;2848.7293707097792;2909.8545072746488;2971.034413815497;2973.747231485326;2977.3747513022076;884.8274586455643;893.066745251214;894.6823877523451;903.8779764731743;904.7150147703452;10925.508352124174;11017.173711971554;11051.115910727123;11053.28153670017;11069.557217711283;4061.89845253871;4172.853950111731;4236.661067114624;4254.106637606075;4317.050248945227;8809.295256379473;8843.823123537493;8846.11538846123;8852.026277109513;8866.157715017063;4640.767961601974;4642.2340313847835;4646.233371493733;4656.604188643935;4660.487346391894;3838.8272527736317;4011.0574015106426;4171.228322760238;4212.87361379153;4278.914421711548;3417.6753208445157;3429.3141371725756;3449.1721986723005;3459.68862802349;3549.3611149992735;978.2467500024941;982.543117450389;985.8859488777636;987.3927534566334;989.3082828363579;777.6772639354717;828.1263267253106;853.1937319233389;873.5675840458887;899.8650202469682;5519.39286678465;5593.664380137205;5615.747291371898;5626.818368142736;5827.737751801179;402.2618495061595;410.27791087685887;412.36289932055047;420.2058110171778;424.448217317486;3857.787821669835;3921.470601468822;3926;3981.664435275572;4032.7983600819844;9793.951030244803;10008.349457285252;10171.440570768678;10200.3369780964;10266.589336426608;10010;10029.648962286285;10117.898821011842;10118.797624047478;10138.341007834468;7636.08366995964;7721.806954826175;7758.418118641124;7760.92239077602;7767.53394796314;5647;5772.480476757112;5777.711114444345;6013.609115407485;6055.6063855849225;8878.334124940784;8963.731088067369;9064;9118.40730352525;9179.219766319937;9091.181793638605;9201.723948281562;9208.079192080739;9286.489243091695;9289.814203716023;6158.907616385847;6882.552634078769;7067.187273463617;7098.112735908012;7170.1754298256365;7885.802854928673;7913.9604301978125;7941.364690824605;7941.364690824836;7996.240357166293;6959.164900212007;7172.856542869009;7177.712891484282;7188.173360063451;7304.817379565553;6637.601743895381;6752.257251702407;6770.763023294358;6852.314768523108;6866.588004719732;6666.83332916681;6688.933110668831;6798.048273241849;6802.421794147553;6824.351686589766;4955.454899961073;5014.749262536786;5030.044291584587;5052.393712754493;5061.013102444987;4964.652474326763;5055.620828437808;5064.797408103635;5080.364954380702;5090.923636145535 07:44:43 INFO - PROCESS | 453 | |4;prototype.html;309.26857980875224;309.5882476306512;311.1598683554404;314.28029811731125;316.45569620253156;5017.724025178613;5023.296738456615;5031.1698569736;5036.169032109707;5036.773345199465;4958.67768595042;4967.081089998353;4978.6514943953935;5006.749662516878;5012.3985121785345;3711.7216208784316;3842.925659472411;3910.5893881142497;3944;3949.6840252779707;3888.5333759948844;3930.3296099157888;3933.3706606942897;3933.8395173423764;3943.107308491926;3899.2786334528205;3922.6273504017217;3928.8232029558594;3942.1130245694776;3946.112124771932;3834.9041273968096;3878.7478813877005;3892.9610703893163;3943.80280985951;3953.071028308331;3392.6429428228657;3401.4557670772806;3401.5748031496064;3411.9764070778665;3415.351083294166;4809.567138957511;4810.374651295309;4817.8313759018265;4836.395450568679;4854.281602302722;4352.869413917556;4430.534793846632;4459.308807134899;4469.687121901468;4492;5248.21276808478;5261.710605916673;5273.525382715536;5283.63014588979;5333.759980800874;3719.939817152099;3780.4329350597354;3794.962050379516;3795.449659799341;3796.221774536241;5301.125314323171;5396.703181325026;5440.047991601494;5455;5466.1527463243265;3830.5594856591847;3850.114473671071;3895.383415882434;3903.531576210816;3934.252492026506;3947.802609869495;3964.187341595024;3974.423708562242;3979.5025621797276;3982.542007669097;4442.600165985013;4476.2837945928495;4483.484399294058;4505.256632655641;4522.140793249338;5085.4914508548845;5185.248139019896;5214.921776173361;5226.451222621646;5233.869153271199;1362.9727405451836;1383.038788042301;1389.145675409636;1390.6870954035262;1394.76289030865;845.9238668519863;866.8353012927523;869.8908891163817;871.2986046232843;876.5529579914289;4354.281543545279;4471.47361740622;4493.348464472633;4512.864614061584;4532.478764942008;5414.675119492843;5418.972905135528;5419.539339156137;5436.238926550286;5440;4387.025838372745;4471.150481408522;4517.096580683877;4519.683622146418;4536.138133754642;2846.1746093632614;2883.423315336941;2892.6094977177813;2896.391757730858;2900.492413827572;5050.823221187241;5058.482455263406;5093.617978651616;5096.796128154906;5110.412302585176;5424.291348225296;5546.195801608744;5580.609357345028;5594.888102237933;5612.971935140298;5060.392752869606;5082.517160869711;5102.4897510248675;5103.795848166032;5146.562542183881;5411.485908838654;5426.348838139448;5443.755031023535;5470.699111548903;5473.261109750133;5151.8196863109615;5235.895282094413;5298.15229563268;5306.54894333986;5315.671082229443;5074.543291103819;5075.416327122428;5087.364079490064;5125.359330083739;5128.897152167742;3868.1683438059827;3877.8061096945603;3881.184951160288;3883.4563161156893;3891.9221615568094;5126.7949282029795;5345.625806193529;5386.811461598825;5424.047342956454;5489.890202196014;5232.3459567554055;5245.973770131125;5247.16349277765;5251.133562962221;5257.108590275409;5219.373675159005;5224.138017227115;5233.241180028798;5233.319668443078;5246.606504512253;4899.461059283547;5206.817761378334;5230.34620672416;5247.89504209906;5253.947460525499;5068.619853510928;5185.196294574347;5306.28365170697;5323.281357016908;5350.277712508761;5195.5843532518065;5204.921926171035;5206.375234971828;5210.270562121382;5229.346331708536 07:44:43 INFO - PROCESS | 453 | |5;yui.html;636.4367534731763;648.5946283572767;712.2414628420731;748.2330611123596;752.7968494057783;11680.941595292023;12562.057845661566;12634.684132896671;12648.367581620916;12674.42965066572;12181.269123852575;12198.085143614242;12236;12270.754584908318;12331.938340308308;617.6232498176109;774.4965772248041;774.740461945249;785.8860465232538;787.2914377060634;800.235774835034;801.6633014134048;803.2890891560982;803.6544285957036;804.6017221475378;838.7693384319331;844.7212419901449;846.0946786937978;848.3043903998723;850.6172222499869;827.9089300177005;832.8917240758693;833.5957060825494;836.7531578184451;838.304207507767;614.9600275982046;618.752499000399;618.9350118237566;618.950483961282;620.4137090449527;11894.82157767634;11912.285262884254;11920.10599205063;11958.342291173982;11967.940160299142;12369.69075773104;12751.10742248043;12763.553275635308;12797.424115914806;13237.139585926883;9776.804463910754;10419.843702344471;10476.3190392625;10773.5690572377;11026.503807328689;4007.779572123532;4029.717919745619;4102.077032667656;4206.516250631186;4328.913421731548;43881.56118438807;44983.32525012128;45118.77440612809;45383.773081134386;45568.3164752529;9824.312298139062;9862.753431164136;9864.753381165385;9880.110790028932;9904.405735655739;16132.67734645324;16195.838041619669;16230.594235143979;16531.66936661284;16679.332826687038;6344.080108384258;6362.777302794472;6420.6147631142285;6475.255345635313;6478.481721462272;3719.9628003719617;3761.605031471711;3768.566614839274;3813.9809300953316;3866.3620502616754;2691.3406215477335;2779.63864697588;2785.220138361262;2801.537746271883;2802.621646077753;518.8780636550408;535.4698848140313;541.0774629257107;542.8262955854088;552.4613501835759;543.1933578635723;545.2557259340971;566.895124401987;573.4724053870449;574.8620331120501;7565.130010048915;7635.732749353857;7775.5723435210475;7802.648880800378;7886.689841329911;450.4751963962013;473.24989891022426;523.6308402576175;523.8057229516708;542.2083757713782;3564.198055437506;3683.37382644951;3728.179800443898;3791.374423220138;3835.232953409329;53930.19104713432;55010.44989550133;55624;55694.16458753122;55839.44160558424;47914.76042619834;47948;49748.75125624421;50210.74894625504;51646;45649;45726.314105288446;45772.54227457749;45996.770016149705;46416.76791616021;7126.643667816692;7302.087239095114;7309.561426314438;7309.597972111372;7310.268973102648;30867;31308.373832523677;31597.684023160393;31938.68061319357;31946.68053319437;36072.639273606925;36696.63303366932;36960;40289;41253;10836.403997780199;10862.728431789268;10967.945160274148;11029;11121.888781112086;11255.774884502427;11550.133739969368;11673.941630292135;11792.469338879599;11812.232204906653;10763.515641796295;11011.834822477509;11325.943370283096;11326.773464530828;11381.146414018816;11018.449077546251;11035.72410689707;11061.778764424827;11281.21031527785;11336.716582085513;10020.09819116283;10193.74515637115;11005.724856878642;11046.779064418506;11998.220115692453;9129.178373946377;9375.73427587267;9385.765355866159;9438.197753190781;9481.620735170516;9729.70810875675;9866.802663946537;9954.104130628279;10059.346142500714;10073.345232559861 07:44:43 INFO - PROCESS | 453 | __end_tp_report 07:44:43 INFO - PROCESS | 453 | __start_cc_report 07:44:43 INFO - PROCESS | 453 | _x_x_mozilla_cycle_collect,385 07:44:43 INFO - PROCESS | 453 | __end_cc_report 07:44:43 INFO - PROCESS | 453 | __startTimestamp1464792283950__endTimestamp 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | ------- Summary: start ------- 07:44:43 INFO - PROCESS | 453 | Number of tests: 6 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#0] dojo.html Cycles:165 Average:4671.13 Median:4815.59 stddev:485.55 (10.1%) stddev-sans-first:459.93 07:44:43 INFO - PROCESS | 453 | Values: 2631.8 2665.6 2716.0 2717.2 2725.6 4635.8 4673.6 4684.3 4752.5 4803.0 4582.1 4694.4 4736.9 4750.8 4755.8 4292.1 4320.1 4392.6 4433.3 4437.8 4128.7 4448.6 4466.7 4495.2 4495.6 4277.4 4281.1 4332.2 4387.6 4462.1 4307.1 4310.9 4313.4 4326.2 4358.1 4336.1 4348.2 4355.3 4362.4 4401.9 4580.8 4619.7 4626.5 4635.7 4676.7 5018.8 5022.4 5043.4 5062.9 5111.3 4930.8 5041.8 5090.7 5093.0 5145.2 4685.5 4722.1 4726.1 4729.5 4732.1 5170.7 5197.6 5198.5 5202.5 5262.7 4850.0 4954.4 4957.3 4961.5 5018.1 5040.1 5062.7 5080.0 5110.7 5121.5 4899.4 4932.9 4940.5 4989.5 5004.0 4950.0 4951.5 4968.6 4998.1 5016.3 4159.9 4201.4 4216.6 4239.3 4292.1 3749.8 3761.4 3765.2 3769.3 3803.1 4298.5 4314.2 4323.7 4330.7 4377.0 4975.3 5073.3 5141.4 5150.8 5154.9 4316.3 4317.4 4320.8 4350.2 4372.6 4526.1 4553.5 4566.8 4567.3 4611.5 4782.0 4782.2 4824.4 4827.9 4829.4 5053.1 5090.6 5105.8 5107.3 5186.0 4661.4 4805.4 4815.6 4838.0 4871.5 5008.3 5009.1 5044.0 5051.5 5066.8 5078.9 5131.8 5141.1 5168.6 5168.7 4780.7 4890.2 4964.1 4992.1 4998.5 4785.7 4857.1 4893.4 4942.4 4997.5 4817.4 4825.3 4830.6 4831.4 4834.6 4847.9 4927.0 4927.5 4937.1 4955.2 4781.9 4827.0 4828.2 4840.0 4844.1 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#1] ext.html Cycles:180 Average:47486.79 Median:36796.41 stddev:87372.79 (237.4%) stddev-sans-first:87546.87 07:44:43 INFO - PROCESS | 453 | Values: 566.1 574.7 584.8 588.6 609.5 35927.6 39991.2 40115.2 40135.8 40142.0 41210.2 42068.8 42128.4 42169.0 42279.8 7556.2 7875.5 7879.6 7885.3 7897.2 7748.0 7812.1 7815.5 7898.2 7911.9 7863.0 7863.1 7916.7 7920.3 7927.0 7798.8 7841.3 7845.3 7869.2 7880.5 7679.2 7734.3 7742.0 7746.4 7753.2 37477.3 37706.6 37784.2 38087.0 38112.4 3197.7 3311.4 3345.6 3353.2 3709.2 30196.7 30307.5 30444.7 30712.0 30813.7 3535.4 3554.4 3564.6 3577.8 3623.4 263684.0 264813.0 266631.0 266756.0 266837.0 32760.7 33692.0 55526.4 55736.4 55926.7 35065.8 35347.3 35540.1 35588.0 35616.1 12896.7 12976.2 12989.5 13024.8 13060.2 11838.1 11962.2 11994.3 12001.9 12020.6 8023.8 8130.1 8145.6 8163.6 8174.7 3179.9 3182.2 3197.0 3225.1 3227.7 866.5 904.5 910.1 923.9 924.7 27565.6 28549.4 28613.1 29049.6 29107.1 903.9 975.4 986.9 1012.6 1026.5 15269.2 15369.1 15453.7 15509.8 15594.4 384206.0 386627.0 387985.0 389393.0 389519.0 50174.7 51095.0 51304.2 51740.2 51749.0 1201.3 1227.5 1239.6 1240.5 1249.2 27769.0 28263.6 28861.8 29190.9 29266.1 45340.5 45401.5 45427.5 45458.0 45907.8 328516.0 328779.0 329395.0 330803.0 331029.0 25632.1 25749.9 26179.6 26189.7 26215.0 43026.6 43343.6 43923.8 44232.3 44691.3 36584.0 36869.8 37154.4 37609.6 37623.8 36725.3 36768.8 36952.3 37081.6 37323.0 35541.5 36128.2 36543.5 36600.3 36824.0 31716.0 32331.7 33063.8 33271.2 33505.0 25361.5 25365.2 25711.4 26680.5 28124.4 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#2] jquery.html Cycles:180 Average:23341.53 Median:5801.23 stddev:64216.02 (1106.9%) stddev-sans-first:64373.00 07:44:43 INFO - PROCESS | 453 | Values: 372.4 383.6 383.6 396.6 401.5 15188.4 17221.6 17276.6 17546.0 17559.7 16600.3 16846.7 17036.9 17342.7 17350.2 4893.2 5018.3 5084.9 5086.5 5096.3 3692.5 5511.3 5793.1 5809.4 5911.3 5817.4 5871.6 5872.1 5873.5 5893.7 5791.0 5890.5 5893.1 5893.3 5945.2 5137.8 5186.4 5199.6 5211.3 5239.3 20417.8 20566.4 20889.4 20937.3 21040.8 1851.6 1944.8 2108.7 2387.9 2474.6 13218.6 13302.2 13383.7 13421.7 13710.7 1727.8 1750.7 1775.3 1786.7 1816.4 66687.7 67647.7 67811.0 68417.0 68547.7 9341.5 9466.7 9494.9 9646.6 9741.9 12963.6 13049.3 13097.4 13099.1 13150.0 6948.9 7013.6 7040.8 7055.7 7357.7 6863.6 6918.9 6923.1 7004.7 7036.8 5933.1 6105.4 6109.3 6132.8 6174.8 1615.7 1704.1 1831.0 1838.1 1844.5 854.9 858.9 940.9 968.7 979.9 15909.9 16710.0 16968.2 17347.3 17359.1 892.4 904.6 940.4 955.2 970.3 9642.7 9865.9 9881.1 9920.9 9994.3 373132.0 389013.0 391054.0 402251.0 402881.0 41172.4 41673.0 66687.7 67387.3 69059.0 951.1 956.3 968.8 993.7 1001.8 15221.8 15223.6 15353.6 15448.7 15543.4 25558.6 32184.0 32192.7 32449.7 32633.0 41363.0 42213.0 42492.2 42985.0 43475.6 7110.6 7111.1 7232.3 7265.5 7285.1 9504.8 10319.3 10449.6 10590.2 10611.5 9107.5 9122.1 9267.7 9321.0 9473.2 9067.5 9167.7 9225.3 9351.0 9471.8 9043.2 9090.1 9235.6 9512.6 9605.6 7145.8 7149.4 7290.9 7336.1 7346.3 6962.8 8299.5 8364.1 8934.3 9071.8 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#3] mootools.html Cycles:180 Average:5294.07 Median:5062.91 stddev:3010.77 (59.5%) stddev-sans-first:3004.90 07:44:43 INFO - PROCESS | 453 | Values: 1385.9 1445.8 1551.0 1768.3 1775.1 7095.5 7733.9 7806.9 8277.9 8312.1 7793.3 8053.4 8090.9 8104.9 8112.2 2167.8 2219.9 2220.7 2224.3 2233.0 2195.5 2199.0 2200.5 2203.0 2252.2 2191.7 2197.7 2209.9 2218.8 2225.1 2116.6 2122.3 2131.3 2136.1 2139.3 2110.9 2123.8 2130.7 2137.9 2138.1 7995.3 8010.5 8024.4 8049.8 8054.9 4545.4 4600.5 4737.0 4740.1 4753.7 2848.7 2909.9 2971.0 2973.7 2977.4 884.8 893.1 894.7 903.9 904.7 10925.5 11017.2 11051.1 11053.3 11069.6 4061.9 4172.9 4236.7 4254.1 4317.1 8809.3 8843.8 8846.1 8852.0 8866.2 4640.8 4642.2 4646.2 4656.6 4660.5 3838.8 4011.1 4171.2 4212.9 4278.9 3417.7 3429.3 3449.2 3459.7 3549.4 978.2 982.5 985.9 987.4 989.3 777.7 828.1 853.2 873.6 899.9 5519.4 5593.7 5615.7 5626.8 5827.7 402.3 410.3 412.4 420.2 424.4 3857.8 3921.5 3926.0 3981.7 4032.8 9794.0 10008.3 10171.4 10200.3 10266.6 10010.0 10029.6 10117.9 10118.8 10138.3 7636.1 7721.8 7758.4 7760.9 7767.5 5647.0 5772.5 5777.7 6013.6 6055.6 8878.3 8963.7 9064.0 9118.4 9179.2 9091.2 9201.7 9208.1 9286.5 9289.8 6158.9 6882.6 7067.2 7098.1 7170.2 7885.8 7914.0 7941.4 7941.4 7996.2 6959.2 7172.9 7177.7 7188.2 7304.8 6637.6 6752.3 6770.8 6852.3 6866.6 6666.8 6688.9 6798.0 6802.4 6824.4 4955.5 5014.7 5030.0 5052.4 5061.0 4964.7 5055.6 5064.8 5080.4 5090.9 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#4] prototype.html Cycles:180 Average:4361.50 Median:5015.06 stddev:1261.84 (25.2%) stddev-sans-first:1228.18 07:44:43 INFO - PROCESS | 453 | Values: 309.3 309.6 311.2 314.3 316.5 5017.7 5023.3 5031.2 5036.2 5036.8 4958.7 4967.1 4978.7 5006.7 5012.4 3711.7 3842.9 3910.6 3944.0 3949.7 3888.5 3930.3 3933.4 3933.8 3943.1 3899.3 3922.6 3928.8 3942.1 3946.1 3834.9 3878.7 3893.0 3943.8 3953.1 3392.6 3401.5 3401.6 3412.0 3415.4 4809.6 4810.4 4817.8 4836.4 4854.3 4352.9 4430.5 4459.3 4469.7 4492.0 5248.2 5261.7 5273.5 5283.6 5333.8 3719.9 3780.4 3795.0 3795.4 3796.2 5301.1 5396.7 5440.0 5455.0 5466.2 3830.6 3850.1 3895.4 3903.5 3934.3 3947.8 3964.2 3974.4 3979.5 3982.5 4442.6 4476.3 4483.5 4505.3 4522.1 5085.5 5185.2 5214.9 5226.5 5233.9 1363.0 1383.0 1389.1 1390.7 1394.8 845.9 866.8 869.9 871.3 876.6 4354.3 4471.5 4493.3 4512.9 4532.5 5414.7 5419.0 5419.5 5436.2 5440.0 4387.0 4471.2 4517.1 4519.7 4536.1 2846.2 2883.4 2892.6 2896.4 2900.5 5050.8 5058.5 5093.6 5096.8 5110.4 5424.3 5546.2 5580.6 5594.9 5613.0 5060.4 5082.5 5102.5 5103.8 5146.6 5411.5 5426.3 5443.8 5470.7 5473.3 5151.8 5235.9 5298.2 5306.5 5315.7 5074.5 5075.4 5087.4 5125.4 5128.9 3868.2 3877.8 3881.2 3883.5 3891.9 5126.8 5345.6 5386.8 5424.0 5489.9 5232.3 5246.0 5247.2 5251.1 5257.1 5219.4 5224.1 5233.2 5233.3 5246.6 4899.5 5206.8 5230.3 5247.9 5253.9 5068.6 5185.2 5306.3 5323.3 5350.3 5195.6 5204.9 5206.4 5210.3 5229.3 07:44:43 INFO - PROCESS | 453 | 07:44:43 INFO - PROCESS | 453 | [#5] yui.html Cycles:180 Average:13014.95 Median:45476.04 stddev:15045.19 (33.1%) stddev-sans-first:15058.68 07:44:43 INFO - PROCESS | 453 | Values: 636.4 648.6 712.2 748.2 752.8 11680.9 12562.1 12634.7 12648.4 12674.4 12181.3 12198.1 12236.0 12270.8 12331.9 617.6 774.5 774.7 785.9 787.3 800.2 801.7 803.3 803.7 804.6 838.8 844.7 846.1 848.3 850.6 827.9 832.9 833.6 836.8 838.3 615.0 618.8 618.9 619.0 620.4 11894.8 11912.3 11920.1 11958.3 11967.9 12369.7 12751.1 12763.6 12797.4 13237.1 9776.8 10419.8 10476.3 10773.6 11026.5 4007.8 4029.7 4102.1 4206.5 4328.9 43881.6 44983.3 45118.8 45383.8 45568.3 9824.3 9862.8 9864.8 9880.1 9904.4 16132.7 16195.8 16230.6 16531.7 16679.3 6344.1 6362.8 6420.6 6475.3 6478.5 3720.0 3761.6 3768.6 3814.0 3866.4 2691.3 2779.6 2785.2 2801.5 2802.6 518.9 535.5 541.1 542.8 552.5 543.2 545.3 566.9 573.5 574.9 7565.1 7635.7 7775.6 7802.6 7886.7 450.5 473.2 523.6 523.8 542.2 3564.2 3683.4 3728.2 3791.4 3835.2 53930.2 55010.4 55624.0 55694.2 55839.4 47914.8 47948.0 49748.8 50210.7 51646.0 45649.0 45726.3 45772.5 45996.8 46416.8 7126.6 7302.1 7309.6 7309.6 7310.3 30867.0 31308.4 31597.7 31938.7 31946.7 36072.6 36696.6 36960.0 40289.0 41253.0 10836.4 10862.7 10967.9 11029.0 11121.9 11255.8 11550.1 11673.9 11792.5 11812.2 10763.5 11011.8 11325.9 11326.8 11381.1 11018.4 11035.7 11061.8 11281.2 11336.7 10020.1 10193.7 11005.7 11046.8 11998.2 9129.2 9375.7 9385.8 9438.2 9481.6 9729.7 9866.8 9954.1 10059.3 10073.3 07:44:43 INFO - PROCESS | 453 | -------- Summary: end -------- 07:44:43 INFO - PROCESS | 453 | 07:44:44 INFO - TEST-INFO | 453: exit 0 07:44:44 INFO - TEST-OK | dromaeo_css | took 1116044ms 07:44:44 INFO - TEST-START | kraken 07:44:44 INFO - operating with platform_type : linux_ 07:44:44 INFO - Initialising browser for kraken test... 07:44:44 INFO - TEST-INFO | started process 695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1rwx6b/profile http://localhost:39376/getInfo.html) 07:44:49 INFO - PROCESS | 695 | __metrics Screen width/height:1600/1200 07:44:49 INFO - PROCESS | 695 | colorDepth:24 07:44:49 INFO - PROCESS | 695 | Browser inner width/height: 1024/697 07:44:49 INFO - PROCESS | 695 | __metrics 07:44:50 ERROR - PROCESS | 695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:44:51 INFO - TEST-INFO | 695: exit 0 07:44:51 INFO - Browser initialized. 07:44:51 INFO - Running cycle 1/1 for kraken test... 07:44:51 INFO - TEST-INFO | started process 816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1rwx6b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:03 INFO - PROCESS | 816 | RSS: Main: 167989248 07:45:03 INFO - PROCESS | 816 | 07:45:06 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39376/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:07 INFO - PROCESS | 816 | RSS: Main: 172339200 07:45:07 INFO - PROCESS | 816 | 07:45:10 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39376/tests/kraken/driver.html?testName=audio-dft) 07:45:10 INFO - PROCESS | 816 | RSS: Main: 172572672 07:45:10 INFO - PROCESS | 816 | 07:45:13 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39376/tests/kraken/driver.html?testName=audio-fft) 07:45:14 INFO - PROCESS | 816 | RSS: Main: 167723008 07:45:14 INFO - PROCESS | 816 | 07:45:16 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39376/tests/kraken/driver.html?testName=audio-oscillator) 07:45:16 INFO - PROCESS | 816 | RSS: Main: 168255488 07:45:16 INFO - PROCESS | 816 | 07:45:19 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:19 INFO - PROCESS | 816 | RSS: Main: 168726528 07:45:19 INFO - PROCESS | 816 | 07:45:22 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39376/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:23 INFO - PROCESS | 816 | RSS: Main: 168935424 07:45:23 INFO - PROCESS | 816 | 07:45:27 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39376/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:27 INFO - PROCESS | 816 | RSS: Main: 166440960 07:45:27 INFO - PROCESS | 816 | 07:45:30 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39376/tests/kraken/driver.html?testName=json-parse-financial) 07:45:31 INFO - PROCESS | 816 | RSS: Main: 168026112 07:45:31 INFO - PROCESS | 816 | 07:45:33 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:33 INFO - PROCESS | 816 | RSS: Main: 168243200 07:45:33 INFO - PROCESS | 816 | 07:45:35 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:36 INFO - PROCESS | 816 | RSS: Main: 168157184 07:45:36 INFO - PROCESS | 816 | 07:45:38 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:39 INFO - PROCESS | 816 | RSS: Main: 168751104 07:45:39 INFO - PROCESS | 816 | 07:45:41 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:42 INFO - PROCESS | 816 | RSS: Main: 168665088 07:45:42 INFO - PROCESS | 816 | 07:45:45 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:46 INFO - PROCESS | 816 | RSS: Main: 168525824 07:45:46 INFO - PROCESS | 816 | 07:45:47 INFO - PROCESS | 816 | Cycle 1(1): loaded http://localhost:39376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39376/tests/kraken/driver.html?testName=ai-astar) 07:45:48 INFO - PROCESS | 816 | RSS: Main: 169607168 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | __start_tp_report 07:45:48 INFO - PROCESS | 816 | _x_x_mozilla_page_load 07:45:48 INFO - PROCESS | 816 | _x_x_mozilla_page_load_details 07:45:48 INFO - PROCESS | 816 | |i|pagename|runs| 07:45:48 INFO - PROCESS | 816 | |0;ai-astar;114;110;114;115;116;117;113;113;113;113 07:45:48 INFO - PROCESS | 816 | |1;audio-beat-detection;162;137;160;188;137;161;159;134;203;131 07:45:48 INFO - PROCESS | 816 | |2;audio-dft;163;164;169;170;163;163;164;164;161;163 07:45:48 INFO - PROCESS | 816 | |3;audio-fft;77;75;76;156;77;76;76;77;159;77 07:45:48 INFO - PROCESS | 816 | |4;audio-oscillator;86;86;139;84;84;85;131;85;85;141 07:45:48 INFO - PROCESS | 816 | |5;imaging-gaussian-blur;118;117;118;118;118;117;118;119;119;118 07:45:48 INFO - PROCESS | 816 | |6;imaging-darkroom;148;147;146;148;146;148;146;148;147;147 07:45:48 INFO - PROCESS | 816 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 07:45:48 INFO - PROCESS | 816 | |8;json-parse-financial;64;69;63;64;64;63;64;64;63;63 07:45:48 INFO - PROCESS | 816 | |9;json-stringify-tinderbox;66;66;65;66;66;66;65;66;66;65 07:45:48 INFO - PROCESS | 816 | |10;stanford-crypto-aes;84;83;84;84;85;85;86;85;113;85 07:45:48 INFO - PROCESS | 816 | |11;stanford-crypto-ccm;136;154;134;132;135;132;142;137;145;138 07:45:48 INFO - PROCESS | 816 | |12;stanford-crypto-pbkdf2;173;169;169;171;171;171;175;225;172;169 07:45:48 INFO - PROCESS | 816 | |13;stanford-crypto-sha256-iterative;69;67;67;69;70;65;68;69;70;65 07:45:48 INFO - PROCESS | 816 | __end_tp_report 07:45:48 INFO - PROCESS | 816 | __start_cc_report 07:45:48 INFO - PROCESS | 816 | _x_x_mozilla_cycle_collect,949 07:45:48 INFO - PROCESS | 816 | __end_cc_report 07:45:48 INFO - PROCESS | 816 | __startTimestamp1464792348159__endTimestamp 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | ------- Summary: start ------- 07:45:48 INFO - PROCESS | 816 | Number of tests: 14 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.93 (1.7%) stddev-sans-first:2.05 07:45:48 INFO - PROCESS | 816 | Values: 114.0 110.0 114.0 115.0 116.0 117.0 113.0 113.0 113.0 113.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:160.50 stddev:23.89 (14.9%) stddev-sans-first:25.27 07:45:48 INFO - PROCESS | 816 | Values: 162.0 137.0 160.0 188.0 137.0 161.0 159.0 134.0 203.0 131.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 07:45:48 INFO - PROCESS | 816 | Values: 163.0 164.0 169.0 170.0 163.0 163.0 164.0 164.0 161.0 163.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.50 stddev:34.22 (44.7%) stddev-sans-first:35.83 07:45:48 INFO - PROCESS | 816 | Values: 77.0 75.0 76.0 156.0 77.0 76.0 76.0 77.0 159.0 77.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:85.00 stddev:25.25 (29.7%) stddev-sans-first:26.22 07:45:48 INFO - PROCESS | 816 | Values: 86.0 86.0 139.0 84.0 84.0 85.0 131.0 85.0 85.0 141.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:45:48 INFO - PROCESS | 816 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 118.0 119.0 119.0 118.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:45:48 INFO - PROCESS | 816 | Values: 148.0 147.0 146.0 148.0 146.0 148.0 146.0 148.0 147.0 147.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:45:48 INFO - PROCESS | 816 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.79 (2.8%) stddev-sans-first:1.90 07:45:48 INFO - PROCESS | 816 | Values: 64.0 69.0 63.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 07:45:48 INFO - PROCESS | 816 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.00 stddev:9.03 (10.6%) stddev-sans-first:9.50 07:45:48 INFO - PROCESS | 816 | Values: 84.0 83.0 84.0 84.0 85.0 85.0 86.0 85.0 113.0 85.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.50 stddev:6.84 (5.0%) stddev-sans-first:7.19 07:45:48 INFO - PROCESS | 816 | Values: 136.0 154.0 134.0 132.0 135.0 132.0 142.0 137.0 145.0 138.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:171.50 stddev:17.15 (10.0%) stddev-sans-first:18.14 07:45:48 INFO - PROCESS | 816 | Values: 173.0 169.0 169.0 171.0 171.0 171.0 175.0 225.0 172.0 169.0 07:45:48 INFO - PROCESS | 816 | 07:45:48 INFO - PROCESS | 816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:69.00 stddev:1.85 (2.7%) stddev-sans-first:1.92 07:45:48 INFO - PROCESS | 816 | Values: 69.0 67.0 67.0 69.0 70.0 65.0 68.0 69.0 70.0 65.0 07:45:48 INFO - PROCESS | 816 | -------- Summary: end -------- 07:45:48 INFO - PROCESS | 816 | 07:45:49 INFO - TEST-INFO | 816: exit 0 07:45:49 INFO - TEST-OK | kraken | took 64449ms 07:45:49 INFO - SUITE-END | took 1180s 07:45:49 INFO - Completed test suite (00:19:40) 07:45:49 INFO - javascript benchmark 07:45:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6291.033355250077, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.763141317281, 2665.5735082386823, 2716.022231996481, 2717.2391730315517, 2725.563909774438, 4635.7913893874775, 4673.556012178842, 4684.297355396692, 4752.453467851198, 4802.975985120078, 4582.1064892346, 4694.413198350207, 4736.857894263169, 4750.7862146203415, 4755.762211889409, 4292.120115376348, 4320.09278051608, 4392.648588112959, 4433.31283651033, 4437.822487100512, 4128.723108124225, 4448.599626033656, 4466.665000124987, 4495.213337665896, 4495.595396414322, 4277.422547956017, 4281.079567892887, 4332.1985432695055, 4387.627051700593, 4462.107578484316, 4307.095509942885, 4310.913781724348, 4313.439252897135, 4326.156399502099, 4358.063016451478, 4336.111097225062, 4348.195583817004, 4355.259605866979, 4362.389265502832, 4401.943533551925, 4580.839670611513, 4619.653525985565, 4626.467956185048, 4635.7218566886095, 4676.7427791471455, 5018.84943451697, 5022.372203474566, 5043.394792624908, 5062.873428164288, 5111.284420181178, 4930.80276788928, 5041.798328066873, 5090.745462726849, 5093.0, 5145.228215767665, 4685.461171965199, 4722.079194557028, 4726.054789042137, 4729.527047295243, 4732.124556956974, 5170.689758614495, 5197.62747345856, 5198.532132108128, 5202.479752024768, 5262.657927234794, 4849.975750121297, 4954.430240522314, 4957.281194226817, 4961.454240033593, 5018.146915024455, 5040.117979353672, 5062.670926389773, 5080.0, 5110.744462776846, 5121.4878512149235, 4899.412070551557, 4932.890099727532, 4940.505949405031, 4989.476105008995, 5004.024215278058, 4950.0, 4951.455339912607, 4968.627352948543, 4998.075356059141, 5016.347874776328, 4159.8960025999595, 4201.369794530845, 4216.578342165821, 4239.342901850218, 4292.141571685613, 3749.7562658427114, 3761.4169803680475, 3765.171662234304, 3769.264993326275, 3803.1062700265416, 4298.527162012176, 4314.201872653569, 4323.697341186087, 4330.718503297276, 4377.015171586368, 4975.328330675385, 5073.34046573943, 5141.408737995179, 5150.768215430315, 5154.92267615986, 4316.330968699856, 4317.438732964694, 4320.848770293024, 4350.151720414552, 4372.584604462571, 4526.140033393644, 4553.54464553542, 4566.817327306937, 4567.337736028324, 4611.469680986729, 4782.0, 4782.234842425195, 4824.396950381202, 4827.879303017453, 4829.444613869309, 5053.11570475158, 5090.643654944267, 5105.821296254613, 5107.310513080686, 5186.014657215117, 4661.394018777537, 4805.3512775774825, 4815.590674792542, 4838.032393521239, 4871.48849370811, 5008.298838162733, 5009.123403404316, 5044.041632089891, 5051.494850514919, 5066.797328106982, 5078.898422031465, 5131.769070391767, 5141.074606570854, 5168.638195326291, 5168.715720635401, 4780.665353425227, 4890.193118135468, 4964.131277026434, 4992.101421744121, 4998.475160108136, 4785.688930219525, 4857.052874689543, 4893.412790465167, 4942.382202224722, 4997.475265097112, 4817.421909370898, 4825.3485779419325, 4830.637702172421, 4831.396075490564, 4834.564889159992, 4847.854564363075, 4926.975365123151, 4927.507249275044, 4937.086638971802, 4955.157623204136, 4781.880452988703, 4827.034593081468, 4828.227483602606, 4839.95160048395, 4844.128056949783], "value": 4640.875596055768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1338152626481, 574.7442388137281, 584.7690162385857, 588.5674029588255, 609.5489337889962, 35927.64072359279, 39991.2001759965, 40115.197696046096, 40135.799321003426, 40142.0, 41210.17579648413, 42068.789656051755, 42128.36807447883, 42169.0, 42279.78860105703, 7556.206598307181, 7875.527468351888, 7879.645415956267, 7885.329746971485, 7897.210278972086, 7747.96126019372, 7812.06255249368, 7815.452918295721, 7898.210178982114, 7911.920880791205, 7863.0, 7863.095743989428, 7916.683332666716, 7920.287174154325, 7926.960365198195, 7798.8440231195345, 7841.333486653642, 7845.254700803414, 7869.173736757615, 7880.487768295071, 7679.1936846631415, 7734.3039126478325, 7742.0, 7746.419018573573, 7753.185915478906, 37477.25045499102, 37706.62293377059, 37784.244315113545, 38087.0, 38112.42831357532, 3197.7441804655805, 3311.420501412267, 3345.631980482145, 3353.2119951811305, 3709.2025214578725, 30196.69803301961, 30307.545386819216, 30444.695553044407, 30712.0, 30813.691863081305, 3535.4166562517153, 3554.413521768905, 3564.6078931317534, 3577.8032208228537, 3623.420252759572, 263684.0, 264812.9999999981, 266631.0, 266756.0, 266837.0, 32760.67239327624, 33692.0, 55526.444735552934, 55736.44263557313, 55926.72036639791, 35065.824670876485, 35347.293054139285, 35540.111497212776, 35588.0, 35616.109597259754, 12896.742065158833, 12976.221426714428, 12989.545365912149, 13024.804627930589, 13060.21638701681, 11838.052955763518, 11962.222455540363, 11994.34031128279, 12001.879981200076, 12020.639380818415, 8023.839523209504, 8130.065042520067, 8145.5927203639585, 8163.632636531371, 8174.713885013996, 3179.856906439216, 3182.172635114887, 3196.9680303197138, 3225.0969728476066, 3227.725643320297, 866.4757821518017, 904.5251243097294, 910.1490106750209, 923.8568021956607, 924.7456949338986, 27565.586516202275, 28549.429011419656, 28613.14160575186, 29049.56425653617, 29107.126786196448, 903.8689390038408, 975.4147511493047, 986.8569057486624, 1012.5797793915442, 1026.5431882812227, 15269.236538173269, 15369.080884374636, 15453.690926181413, 15509.767353489706, 15594.376224950875, 384206.0, 386627.0, 387985.0, 389393.0, 389519.0, 50174.74912625414, 51095.0, 51304.23043654348, 51740.22389664158, 51749.0, 1201.2672269915345, 1227.4660522672666, 1239.5661518468464, 1240.5472002719123, 1249.2067537113999, 27769.0, 28263.576046359733, 28861.82519922849, 29190.854045729637, 29266.122016339545, 45340.54659453495, 45401.545984539734, 45427.54572454233, 45458.0, 45907.770461147484, 328516.0, 328779.0, 329395.0, 330803.0, 331029.0, 25632.077594180137, 25749.871250643628, 26179.607305890047, 26189.738102619493, 26215.0, 43026.569734302255, 43343.56656433395, 43923.78038109789, 44232.33651495294, 44691.32963005623, 36584.0, 36869.81565092158, 37154.44268335923, 37609.623903760614, 37623.81188094042, 36725.26549469049, 36768.81615592012, 36952.26095478129, 37081.62918370782, 37323.0, 35541.466877997365, 36128.20653831415, 36543.45184822177, 36600.26799463943, 36824.0, 31716.0, 32331.676683232865, 33063.83468082644, 33271.16822079467, 33505.0, 25361.492770144123, 25365.239042828744, 25711.357216069748, 26680.466390672467, 28124.437511249253], "value": 16845.38074607756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.4153079664927, 383.55890725665483, 383.5922165652058, 396.6410398589278, 401.5201833808598, 15188.392464301429, 17221.569460763487, 17276.568085797862, 17546.03496807675, 17559.736603950936, 16600.25298861551, 16846.66306673869, 17036.892601980864, 17342.739858902096, 17350.219240134193, 4893.217085266349, 5018.272350509174, 5084.898302033957, 5086.465921078289, 5096.261042148886, 3692.48305237267, 5511.338639363282, 5793.102069179284, 5809.3609702932645, 5911.3201981772, 5817.360090390053, 5871.647701137924, 5872.148538461921, 5873.530117590582, 5893.7347819348015, 5791.0, 5890.528757699417, 5893.14549390336, 5893.263342082239, 5945.197398351233, 5137.840228259631, 5186.377634683862, 5199.558037566811, 5211.296474975868, 5239.266502689627, 20417.79582204174, 20566.38300850977, 20889.37331880046, 20937.26719564823, 21040.789592104036, 1851.5833937363984, 1944.7860735319105, 2108.7153234313323, 2387.9403014924765, 2474.6288056791445, 13218.60344189676, 13302.201867887958, 13383.732325353536, 13421.731565368736, 13710.725785484334, 1727.8444939955339, 1750.6586215687946, 1775.254393154878, 1786.7135662323108, 1816.373351193836, 66687.66656166737, 67647.66176169137, 67811.0, 68416.97374539435, 68547.65726171338, 9341.532923353805, 9466.668666596774, 9494.905050949403, 9646.565904534313, 9741.902580974242, 12963.611091667264, 13049.28228947398, 13097.41061652228, 13099.148555344063, 13150.013748968866, 6948.895766563505, 7013.579185248901, 7040.823979400556, 7055.7177712891935, 7357.705691772377, 6863.627274545111, 6918.8962165567555, 6923.065386172903, 7004.719811207597, 7036.753713619999, 5933.131063714916, 6105.419985101408, 6109.327973922865, 6132.846678833065, 6174.783882564088, 1615.668787898478, 1704.1479260369815, 1830.9908450457663, 1838.1032211711258, 1844.4651051195003, 854.9273311768445, 858.914108589136, 940.9059094090674, 968.651285537206, 979.8628192053118, 15909.920450397674, 16710.0, 16968.23642936071, 17347.306107755547, 17359.132043397778, 892.4065496444921, 904.6471875968377, 940.4075432477496, 955.2358113509165, 970.2771435280761, 9642.662506812228, 9865.901340986642, 9881.110700037032, 9920.851187232198, 9994.250431217688, 373132.0, 389013.0, 391054.0, 402251.0, 402880.9855950702, 41172.38160494952, 41673.0, 66687.66656166785, 67387.32612673909, 69059.0, 951.0917074194128, 956.3401253135314, 968.7626531499827, 993.6820217530321, 1001.7595777013464, 15221.847781522487, 15223.619409514851, 15353.6161595961, 15448.691026179638, 15543.378264869278, 25558.616620751076, 32184.03447896567, 32192.67807321897, 32449.675503244664, 32633.0, 41363.0, 42213.045086843624, 42492.15015699607, 42985.0, 43475.56524434715, 7110.6089165094345, 7111.111111111111, 7232.276772322725, 7265.491415600857, 7285.089363829521, 9504.809903802023, 10319.329243599143, 10449.582016719247, 10590.152787776806, 10611.469426528796, 9107.544622768703, 9122.087791220825, 9267.67563135287, 9320.95339523298, 9473.158052584335, 9067.546622668708, 9167.679131230641, 9225.261979041794, 9351.0, 9471.810563788547, 9043.231325337158, 9090.090990900857, 9235.630574777202, 9512.619495220113, 9605.615775368908, 7145.785626431215, 7149.428045756431, 7290.890636640349, 7336.119665640157, 7346.265373462825, 6962.756303529352, 8299.460535065202, 8364.079951205242, 8934.329925255503, 9071.818563628822], "value": 8130.667356007126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.861413858614, 1445.8409574946756, 1550.9612259693506, 1768.275007247029, 1775.1124437781118, 7095.503314767969, 7733.883991740115, 7806.882896756546, 8277.91722082779, 8312.127226641207, 7793.298603125718, 8053.355731541477, 8090.878636820453, 8104.878426823602, 8112.188781121885, 2167.7615462299173, 2219.889005549724, 2220.711307530019, 2224.3215819175143, 2233.0, 2195.4621117826077, 2199.0, 2200.515886504966, 2202.966955495669, 2252.1892118837204, 2191.7150770399826, 2197.6593627987686, 2209.8784566848817, 2218.811401030914, 2225.087714037245, 2116.640171170897, 2122.3102491690183, 2131.2753663754243, 2136.0708091980036, 2139.2512620582747, 2110.8733475991335, 2123.8088572028437, 2130.7017017617545, 2137.9144834206613, 2138.134055707441, 7995.280424761741, 8010.479318844256, 8024.398170137263, 8049.798755031171, 8054.919450805475, 4545.386372839657, 4600.5169457207185, 4737.028909073631, 4740.051989602093, 4753.714777113384, 2848.7293707097792, 2909.8545072746488, 2971.034413815497, 2973.747231485326, 2977.3747513022076, 884.8274586455643, 893.066745251214, 894.6823877523451, 903.8779764731743, 904.7150147703452, 10925.508352124174, 11017.173711971554, 11051.115910727123, 11053.28153670017, 11069.557217711283, 4061.89845253871, 4172.853950111731, 4236.661067114624, 4254.106637606075, 4317.050248945227, 8809.295256379473, 8843.823123537493, 8846.11538846123, 8852.026277109513, 8866.157715017063, 4640.767961601974, 4642.2340313847835, 4646.233371493733, 4656.604188643935, 4660.487346391894, 3838.8272527736317, 4011.0574015106426, 4171.228322760238, 4212.87361379153, 4278.914421711548, 3417.6753208445157, 3429.3141371725756, 3449.1721986723005, 3459.68862802349, 3549.3611149992735, 978.2467500024941, 982.543117450389, 985.8859488777636, 987.3927534566334, 989.3082828363579, 777.6772639354717, 828.1263267253106, 853.1937319233389, 873.5675840458887, 899.8650202469682, 5519.39286678465, 5593.664380137205, 5615.747291371898, 5626.818368142736, 5827.737751801179, 402.2618495061595, 410.27791087685887, 412.36289932055047, 420.2058110171778, 424.448217317486, 3857.787821669835, 3921.470601468822, 3926.0, 3981.664435275572, 4032.7983600819844, 9793.951030244803, 10008.349457285252, 10171.440570768678, 10200.3369780964, 10266.589336426608, 10010.0, 10029.648962286285, 10117.898821011842, 10118.797624047478, 10138.341007834468, 7636.08366995964, 7721.806954826175, 7758.418118641124, 7760.92239077602, 7767.53394796314, 5647.0, 5772.480476757112, 5777.711114444345, 6013.609115407485, 6055.6063855849225, 8878.334124940784, 8963.731088067369, 9064.0, 9118.40730352525, 9179.219766319937, 9091.181793638605, 9201.723948281562, 9208.079192080739, 9286.489243091695, 9289.814203716023, 6158.907616385847, 6882.552634078769, 7067.187273463617, 7098.112735908012, 7170.1754298256365, 7885.802854928673, 7913.9604301978125, 7941.364690824605, 7941.364690824836, 7996.240357166293, 6959.164900212007, 7172.856542869009, 7177.712891484282, 7188.173360063451, 7304.817379565553, 6637.601743895381, 6752.257251702407, 6770.763023294358, 6852.314768523108, 6866.588004719732, 6666.83332916681, 6688.933110668831, 6798.048273241849, 6802.421794147553, 6824.351686589766, 4955.454899961073, 5014.749262536786, 5030.044291584587, 5052.393712754493, 5061.013102444987, 4964.652474326763, 5055.620828437808, 5064.797408103635, 5080.364954380702, 5090.923636145535], "value": 4148.380825886366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.26857980875224, 309.5882476306512, 311.1598683554404, 314.28029811731125, 316.45569620253156, 5017.724025178613, 5023.296738456615, 5031.1698569736, 5036.169032109707, 5036.773345199465, 4958.67768595042, 4967.081089998353, 4978.6514943953935, 5006.749662516878, 5012.3985121785345, 3711.7216208784316, 3842.925659472411, 3910.5893881142497, 3944.0, 3949.6840252779707, 3888.5333759948844, 3930.3296099157888, 3933.3706606942897, 3933.8395173423764, 3943.107308491926, 3899.2786334528205, 3922.6273504017217, 3928.8232029558594, 3942.1130245694776, 3946.112124771932, 3834.9041273968096, 3878.7478813877005, 3892.9610703893163, 3943.80280985951, 3953.071028308331, 3392.6429428228657, 3401.4557670772806, 3401.5748031496064, 3411.9764070778665, 3415.351083294166, 4809.567138957511, 4810.374651295309, 4817.8313759018265, 4836.395450568679, 4854.281602302722, 4352.869413917556, 4430.534793846632, 4459.308807134899, 4469.687121901468, 4492.0, 5248.21276808478, 5261.710605916673, 5273.525382715536, 5283.63014588979, 5333.759980800874, 3719.939817152099, 3780.4329350597354, 3794.962050379516, 3795.449659799341, 3796.221774536241, 5301.125314323171, 5396.703181325026, 5440.047991601494, 5455.0, 5466.1527463243265, 3830.5594856591847, 3850.114473671071, 3895.383415882434, 3903.531576210816, 3934.252492026506, 3947.802609869495, 3964.187341595024, 3974.423708562242, 3979.5025621797276, 3982.542007669097, 4442.600165985013, 4476.2837945928495, 4483.484399294058, 4505.256632655641, 4522.140793249338, 5085.4914508548845, 5185.248139019896, 5214.921776173361, 5226.451222621646, 5233.869153271199, 1362.9727405451836, 1383.038788042301, 1389.145675409636, 1390.6870954035262, 1394.76289030865, 845.9238668519863, 866.8353012927523, 869.8908891163817, 871.2986046232843, 876.5529579914289, 4354.281543545279, 4471.47361740622, 4493.348464472633, 4512.864614061584, 4532.478764942008, 5414.675119492843, 5418.972905135528, 5419.539339156137, 5436.238926550286, 5440.0, 4387.025838372745, 4471.150481408522, 4517.096580683877, 4519.683622146418, 4536.138133754642, 2846.1746093632614, 2883.423315336941, 2892.6094977177813, 2896.391757730858, 2900.492413827572, 5050.823221187241, 5058.482455263406, 5093.617978651616, 5096.796128154906, 5110.412302585176, 5424.291348225296, 5546.195801608744, 5580.609357345028, 5594.888102237933, 5612.971935140298, 5060.392752869606, 5082.517160869711, 5102.4897510248675, 5103.795848166032, 5146.562542183881, 5411.485908838654, 5426.348838139448, 5443.755031023535, 5470.699111548903, 5473.261109750133, 5151.8196863109615, 5235.895282094413, 5298.15229563268, 5306.54894333986, 5315.671082229443, 5074.543291103819, 5075.416327122428, 5087.364079490064, 5125.359330083739, 5128.897152167742, 3868.1683438059827, 3877.8061096945603, 3881.184951160288, 3883.4563161156893, 3891.9221615568094, 5126.7949282029795, 5345.625806193529, 5386.811461598825, 5424.047342956454, 5489.890202196014, 5232.3459567554055, 5245.973770131125, 5247.16349277765, 5251.133562962221, 5257.108590275409, 5219.373675159005, 5224.138017227115, 5233.241180028798, 5233.319668443078, 5246.606504512253, 4899.461059283547, 5206.817761378334, 5230.34620672416, 5247.89504209906, 5253.947460525499, 5068.619853510928, 5185.196294574347, 5306.28365170697, 5323.281357016908, 5350.277712508761, 5195.5843532518065, 5204.921926171035, 5206.375234971828, 5210.270562121382, 5229.346331708536], "value": 3960.0964130788425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.4367534731763, 648.5946283572767, 712.2414628420731, 748.2330611123596, 752.7968494057783, 11680.941595292023, 12562.057845661566, 12634.684132896671, 12648.367581620916, 12674.42965066572, 12181.269123852575, 12198.085143614242, 12236.0, 12270.754584908318, 12331.938340308308, 617.6232498176109, 774.4965772248041, 774.740461945249, 785.8860465232538, 787.2914377060634, 800.235774835034, 801.6633014134048, 803.2890891560982, 803.6544285957036, 804.6017221475378, 838.7693384319331, 844.7212419901449, 846.0946786937978, 848.3043903998723, 850.6172222499869, 827.9089300177005, 832.8917240758693, 833.5957060825494, 836.7531578184451, 838.304207507767, 614.9600275982046, 618.752499000399, 618.9350118237566, 618.950483961282, 620.4137090449527, 11894.82157767634, 11912.285262884254, 11920.10599205063, 11958.342291173982, 11967.940160299142, 12369.69075773104, 12751.10742248043, 12763.553275635308, 12797.424115914806, 13237.139585926883, 9776.804463910754, 10419.843702344471, 10476.3190392625, 10773.5690572377, 11026.503807328689, 4007.779572123532, 4029.717919745619, 4102.077032667656, 4206.516250631186, 4328.913421731548, 43881.56118438807, 44983.32525012128, 45118.77440612809, 45383.773081134386, 45568.3164752529, 9824.312298139062, 9862.753431164136, 9864.753381165385, 9880.110790028932, 9904.405735655739, 16132.67734645324, 16195.838041619669, 16230.594235143979, 16531.66936661284, 16679.332826687038, 6344.080108384258, 6362.777302794472, 6420.6147631142285, 6475.255345635313, 6478.481721462272, 3719.9628003719617, 3761.605031471711, 3768.566614839274, 3813.9809300953316, 3866.3620502616754, 2691.3406215477335, 2779.63864697588, 2785.220138361262, 2801.537746271883, 2802.621646077753, 518.8780636550408, 535.4698848140313, 541.0774629257107, 542.8262955854088, 552.4613501835759, 543.1933578635723, 545.2557259340971, 566.895124401987, 573.4724053870449, 574.8620331120501, 7565.130010048915, 7635.732749353857, 7775.5723435210475, 7802.648880800378, 7886.689841329911, 450.4751963962013, 473.24989891022426, 523.6308402576175, 523.8057229516708, 542.2083757713782, 3564.198055437506, 3683.37382644951, 3728.179800443898, 3791.374423220138, 3835.232953409329, 53930.19104713432, 55010.44989550133, 55624.0, 55694.16458753122, 55839.44160558424, 47914.76042619834, 47948.0, 49748.75125624421, 50210.74894625504, 51646.0, 45649.0, 45726.314105288446, 45772.54227457749, 45996.770016149705, 46416.76791616021, 7126.643667816692, 7302.087239095114, 7309.561426314438, 7309.597972111372, 7310.268973102648, 30867.0, 31308.373832523677, 31597.684023160393, 31938.68061319357, 31946.68053319437, 36072.639273606925, 36696.63303366932, 36960.0, 40289.0, 41253.0, 10836.403997780199, 10862.728431789268, 10967.945160274148, 11029.0, 11121.888781112086, 11255.774884502427, 11550.133739969368, 11673.941630292135, 11792.469338879599, 11812.232204906653, 10763.515641796295, 11011.834822477509, 11325.943370283096, 11326.773464530828, 11381.146414018816, 11018.449077546251, 11035.72410689707, 11061.778764424827, 11281.21031527785, 11336.716582085513, 10020.09819116283, 10193.74515637115, 11005.724856878642, 11046.779064418506, 11998.220115692453, 9129.178373946377, 9375.73427587267, 9385.765355866159, 9438.197753190781, 9481.620735170516, 9729.70810875675, 9866.802663946537, 9954.104130628279, 10059.346142500714, 10073.345232559861], "value": 5936.008556429661, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 115.0, 116.0, 117.0, 113.0, 113.0, 113.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 137.0, 160.0, 188.0, 137.0, 161.0, 159.0, 134.0, 203.0, 131.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 169.0, 170.0, 163.0, 163.0, 164.0, 164.0, 161.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 156.0, 77.0, 76.0, 76.0, 77.0, 159.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 139.0, 84.0, 84.0, 85.0, 131.0, 85.0, 85.0, 141.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 85.0, 85.0, 86.0, 85.0, 113.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 154.0, 134.0, 132.0, 135.0, 132.0, 142.0, 137.0, 145.0, 138.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 169.0, 171.0, 171.0, 171.0, 175.0, 225.0, 172.0, 169.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 69.0, 70.0, 65.0, 68.0, 69.0, 70.0, 65.0], "value": 67.9, "unit": "score"}]}]} 07:45:49 INFO - Return code: 0 07:45:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:45:49 ERROR - # TBPL SUCCESS # 07:45:49 INFO - Running post-action listener: _resource_record_post_action 07:45:49 INFO - ##### 07:45:49 INFO - ##### Finished run-tests step (success) 07:45:49 INFO - ##### 07:45:49 INFO - Running post-run listener: _resource_record_post_run 07:45:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371281920; Read time: 20; Write time: 381988 07:45:49 INFO - TinderboxPrint: CPU usage
13.4% 07:45:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:45:49 INFO - TinderboxPrint: I/O write bytes / time
371,281,920 / 381,988 07:45:49 INFO - TinderboxPrint: CPU idle
8,274.2 (86.6%) 07:45:49 INFO - TinderboxPrint: CPU user
1,229.0 (12.9%) 07:45:49 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 80056320; Read time: 0; Write time: 52312 07:45:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291225600; Read time: 20; Write time: 329676 07:45:50 INFO - Running post-run listener: _upload_blobber_files 07:45:50 INFO - Blob upload gear active. 07:45:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:50 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 07:45:50 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'] 07:45:50 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 07:45:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:54 INFO - (blobuploader) - INFO - Done attempting. 07:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:55 INFO - (blobuploader) - INFO - Done attempting. 07:45:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:55 INFO - (blobuploader) - INFO - Done attempting. 07:45:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:55 INFO - Return code: 0 07:45:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c37943eb18ad97f75182636dcf7e5b67546a2ddb9155e06afa679e24290dad396b9a900e43d95b75c48bfea959631efd165afab53fdf57e1988cc16bfb9540f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15da29ca91a704e625ab36cc0ffa66e3ce916a8129ac067d07b19b4fb4390af1daa6a5bf13ba3fb9ea82a62829428f955fa90a1db20982cbcf9d51ab5228ed67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2320c5bd288359b95ba88392addea578f115a39a95acc37c9f40311364eec39af2011163fa83573a53fe7b43c03e6cae6c96d2943cdeedb89411fc5f7d53b86"} 07:45:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:55 INFO - Contents: 07:45:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c37943eb18ad97f75182636dcf7e5b67546a2ddb9155e06afa679e24290dad396b9a900e43d95b75c48bfea959631efd165afab53fdf57e1988cc16bfb9540f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15da29ca91a704e625ab36cc0ffa66e3ce916a8129ac067d07b19b4fb4390af1daa6a5bf13ba3fb9ea82a62829428f955fa90a1db20982cbcf9d51ab5228ed67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2320c5bd288359b95ba88392addea578f115a39a95acc37c9f40311364eec39af2011163fa83573a53fe7b43c03e6cae6c96d2943cdeedb89411fc5f7d53b86"} 07:45:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:55 INFO - Copying logs to upload dir... 07:45:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.264227 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-01 07:45:55.756559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:55.759902) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 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/c37943eb18ad97f75182636dcf7e5b67546a2ddb9155e06afa679e24290dad396b9a900e43d95b75c48bfea959631efd165afab53fdf57e1988cc16bfb9540f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15da29ca91a704e625ab36cc0ffa66e3ce916a8129ac067d07b19b4fb4390af1daa6a5bf13ba3fb9ea82a62829428f955fa90a1db20982cbcf9d51ab5228ed67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2320c5bd288359b95ba88392addea578f115a39a95acc37c9f40311364eec39af2011163fa83573a53fe7b43c03e6cae6c96d2943cdeedb89411fc5f7d53b86"} build_url:https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.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/c37943eb18ad97f75182636dcf7e5b67546a2ddb9155e06afa679e24290dad396b9a900e43d95b75c48bfea959631efd165afab53fdf57e1988cc16bfb9540f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15da29ca91a704e625ab36cc0ffa66e3ce916a8129ac067d07b19b4fb4390af1daa6a5bf13ba3fb9ea82a62829428f955fa90a1db20982cbcf9d51ab5228ed67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2320c5bd288359b95ba88392addea578f115a39a95acc37c9f40311364eec39af2011163fa83573a53fe7b43c03e6cae6c96d2943cdeedb89411fc5f7d53b86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:55.785381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:55.785711) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464791106.354804-917206652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:55.870373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:45:55.870719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:45:55.871037) ========= ========= Total master_lag: 0.18 =========