builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1464702256.15 results: success (0) buildid: 20160531053439 builduid: f866d3b1a2794dd298a1ae0703747f9c revision: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.153722) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.154096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.154370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.183639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.183898) ========= 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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 06:44:16-- 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% 221M=0s 2016-05-31 06:44:16 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.320961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.321241) ========= 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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015938 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.389324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:16.389643) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af81ae8922d6a90dc0413bb1c0f8fdf176a628fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af81ae8922d6a90dc0413bb1c0f8fdf176a628fa --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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 06:44:16,420 truncating revision to first 12 chars 2016-05-31 06:44:16,420 Setting DEBUG logging. 2016-05-31 06:44:16,420 attempt 1/10 2016-05-31 06:44:16,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af81ae8922d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 06:44:16,753 unpacking tar archive at: fx-team-af81ae8922d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.091853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.092154) ========= script_repo_revision: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.092589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.092899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 06:44:17.105336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-31 06:44:17.105657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:17 INFO - MultiFileLogger online at 20160531 06:44:17 in /builds/slave/test 06:44:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:44:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:17 INFO - {'append_to_log': False, 06:44:17 INFO - 'base_work_dir': '/builds/slave/test', 06:44:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:44:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:17 INFO - 'branch': 'Fx-Team-Non-PGO', 06:44:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:17 INFO - 'config_files': ('talos/linux_config.py',), 06:44:17 INFO - 'default_actions': ('clobber', 06:44:17 INFO - 'read-buildbot-config', 06:44:17 INFO - 'download-and-extract', 06:44:17 INFO - 'populate-webroot', 06:44:17 INFO - 'create-virtualenv', 06:44:17 INFO - 'install', 06:44:17 INFO - 'run-tests'), 06:44:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:17 INFO - 'download_minidump_stackwalk': True, 06:44:17 INFO - 'download_symbols': 'ondemand', 06:44:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:17 INFO - 'installer_path': 'installer.exe', 06:44:17 INFO - 'log_level': 'info', 06:44:17 INFO - 'log_name': 'talos', 06:44:17 INFO - 'log_to_console': True, 06:44:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:17 INFO - 'opt_config_files': (), 06:44:17 INFO - 'pip_index': False, 06:44:17 INFO - 'sps_profile': False, 06:44:17 INFO - 'sps_profile_interval': 0, 06:44:17 INFO - 'suite': 'dromaeojs-e10s', 06:44:17 INFO - 'system_bits': '32', 06:44:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:17 INFO - 'title': 'talos-linux64-ix-003', 06:44:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:17 INFO - 'use_talos_json': True, 06:44:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:17 INFO - 'work_dir': 'build'} 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running clobber step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: clobber 06:44:17 INFO - rmtree: /builds/slave/test/build 06:44:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:17 INFO - Running post-action listener: _resource_record_post_action 06:44:17 INFO - ##### 06:44:17 INFO - ##### Finished clobber step (success) 06:44:17 INFO - ##### 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running read-buildbot-config step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: read_buildbot_config 06:44:17 INFO - Using buildbot properties: 06:44:17 INFO - { 06:44:17 INFO - "project": "", 06:44:17 INFO - "product": "firefox", 06:44:17 INFO - "script_repo_revision": "production", 06:44:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:44:17 INFO - "repository": "", 06:44:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:44:17 INFO - "buildid": "20160531053439", 06:44:17 INFO - "pgo_build": "False", 06:44:17 INFO - "basedir": "/builds/slave/test", 06:44:17 INFO - "buildnumber": 1328, 06:44:17 INFO - "slavename": "talos-linux64-ix-003", 06:44:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:44:17 INFO - "platform": "ubuntu64_hw", 06:44:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:44:17 INFO - "branch": "fx-team", 06:44:17 INFO - "repo_path": "integration/fx-team", 06:44:17 INFO - "revision": "af81ae8922d6a90dc0413bb1c0f8fdf176a628fa", 06:44:17 INFO - "stage_platform": "linux64", 06:44:17 INFO - "builduid": "f866d3b1a2794dd298a1ae0703747f9c", 06:44:17 INFO - "slavebuilddir": "test" 06:44:17 INFO - } 06:44:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:44:17 INFO - Running post-action listener: _resource_record_post_action 06:44:17 INFO - ##### 06:44:17 INFO - ##### Finished read-buildbot-config step (success) 06:44:17 INFO - ##### 06:44:17 INFO - ##### 06:44:17 INFO - ##### Running download-and-extract step. 06:44:17 INFO - ##### 06:44:17 INFO - Running pre-action listener: _resource_record_pre_action 06:44:17 INFO - Running main action method: download_and_extract 06:44:17 INFO - mkdir: /builds/slave/test/build/tests 06:44:17 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')]} 06:44:17 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:23 INFO - Downloaded 1361 bytes. 06:44:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:44:23 INFO - Using the following test package requirements: 06:44:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:44:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:44:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'jsshell-linux-x86_64.zip'], 06:44:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:44:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:44:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:44:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:44:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:44:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:44:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:44:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:44:23 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')]} 06:44:23 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:24 INFO - Downloaded 22840449 bytes. 06:44:24 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'] 06:44:24 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 06:44:26 INFO - Return code: 0 06:44:26 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 06:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:26 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:27 INFO - Downloaded 22840449 bytes. 06:44:27 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'] 06:44:27 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 06:44:29 INFO - Return code: 0 06:44:29 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')]} 06:44:29 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:30 INFO - Downloaded 10834055 bytes. 06:44:30 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'] 06:44:30 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 06:44:31 INFO - Return code: 0 06:44: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')]} 06:44:31 INFO - https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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 06:44:38 INFO - Downloaded 55033677 bytes. 06:44:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:38 INFO - mkdir: /builds/slave/test/properties 06:44:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:38 INFO - Contents: 06:44:38 INFO - build_url:https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:44:39 INFO - Running post-action listener: _resource_record_post_action 06:44:39 INFO - Running post-action listener: set_extra_try_arguments 06:44:39 INFO - ##### 06:44:39 INFO - ##### Finished download-and-extract step (success) 06:44:39 INFO - ##### 06:44:39 INFO - ##### 06:44:39 INFO - ##### Running populate-webroot step. 06:44:39 INFO - ##### 06:44:39 INFO - Running pre-action listener: _resource_record_pre_action 06:44:39 INFO - Running main action method: populate_webroot 06:44:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:39 INFO - '--tppagecycles', 06:44:39 INFO - '7'], 06:44:39 INFO - 'tests': ['tsvgm']}}, 06:44:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['damp', 'tps']}, 06:44:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'tests': ['damp', 'tps']}, 06:44:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['dromaeo_dom']}, 06:44:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['a11yr', 06:44:39 INFO - 'ts_paint', 06:44:39 INFO - 'tpaint', 06:44:39 INFO - 'sessionrestore', 06:44:39 INFO - 'sessionrestore_no_auto_restore', 06:44:39 INFO - 'tabpaint']}, 06:44:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['tsvgx', 06:44:39 INFO - 'tsvgr_opacity', 06:44:39 INFO - 'tart', 06:44:39 INFO - 'tscrollx', 06:44:39 INFO - 'cart']}, 06:44:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:39 INFO - 'tsvgr_opacity', 06:44:39 INFO - 'tart', 06:44:39 INFO - 'tscrollx', 06:44:39 INFO - 'cart']}, 06:44:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'talos_options': ['--disable-e10s'], 06:44:39 INFO - 'tests': ['tp5o']}, 06:44:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'tests': ['tp5o']}, 06:44:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'talos_options': ['--disable-e10s', 06:44:39 INFO - '--xperf_path', 06:44:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:39 INFO - 'tests': ['tp5n']}, 06:44:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:39 INFO - 'talos_options': ['--xperf_path', 06:44:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:39 INFO - 'tests': ['tp5n']}}, 06:44:39 INFO - 'talos.zip': {'path': '', 06:44:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:39 INFO - Running post-action listener: _resource_record_post_action 06:44:39 INFO - ##### 06:44:39 INFO - ##### Finished populate-webroot step (success) 06:44:39 INFO - ##### 06:44:39 INFO - ##### 06:44:39 INFO - ##### Running create-virtualenv step. 06:44:39 INFO - ##### 06:44:39 INFO - Running pre-action listener: _resource_record_pre_action 06:44:39 INFO - Running main action method: create_virtualenv 06:44:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:39 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 06:44:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:39 INFO - Using real prefix '/usr' 06:44:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:41 INFO - Installing pip.................done. 06:44:41 INFO - Return code: 0 06:44:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:41 INFO - Using env: {'DISPLAY': ':0', 06:44:41 INFO - 'HOME': '/home/cltbld', 06:44:41 INFO - 'LANG': 'en_US.UTF-8', 06:44:41 INFO - 'LANGUAGE': 'en_US:en', 06:44:41 INFO - 'LOGNAME': 'cltbld', 06:44:41 INFO - 'MAIL': '/var/mail/cltbld', 06:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:41 INFO - 'MOZ_NO_REMOTE': '1', 06:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:41 INFO - 'NO_EM_RESTART': '1', 06:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:41 INFO - 'PWD': '/builds/slave/test', 06:44:41 INFO - 'SHELL': '/bin/bash', 06:44:41 INFO - 'SHLVL': '1', 06:44:41 INFO - 'TERM': 'linux', 06:44:41 INFO - 'TMOUT': '86400', 06:44:41 INFO - 'USER': 'cltbld', 06:44:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:41 INFO - '_': '/tools/buildbot/bin/python'} 06:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:44:41 INFO - Cleaning up... 06:44:41 INFO - Return code: 0 06:44:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:44:41 INFO - Using env: {'DISPLAY': ':0', 06:44:41 INFO - 'HOME': '/home/cltbld', 06:44:41 INFO - 'LANG': 'en_US.UTF-8', 06:44:41 INFO - 'LANGUAGE': 'en_US:en', 06:44:41 INFO - 'LOGNAME': 'cltbld', 06:44:41 INFO - 'MAIL': '/var/mail/cltbld', 06:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:41 INFO - 'MOZ_NO_REMOTE': '1', 06:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:41 INFO - 'NO_EM_RESTART': '1', 06:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:41 INFO - 'PWD': '/builds/slave/test', 06:44:41 INFO - 'SHELL': '/bin/bash', 06:44:41 INFO - 'SHLVL': '1', 06:44:41 INFO - 'TERM': 'linux', 06:44:41 INFO - 'TMOUT': '86400', 06:44:41 INFO - 'USER': 'cltbld', 06:44:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:41 INFO - '_': '/tools/buildbot/bin/python'} 06:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:42 INFO - Downloading/unpacking psutil>=3.1.1 06:44:42 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 06:44:42 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 06:44:42 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 06:44:42 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 06:44:42 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 06:44:42 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 06:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:44 INFO - Installing collected packages: psutil 06:44:44 INFO - Running setup.py install for psutil 06:44:44 INFO - building 'psutil._psutil_linux' extension 06:44:44 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 06:44:44 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 06:44:44 INFO - building 'psutil._psutil_posix' extension 06:44:44 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 06:44:44 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 06:44:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:44 INFO - Successfully installed psutil 06:44:44 INFO - Cleaning up... 06:44:44 INFO - Return code: 0 06:44:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:44 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')]} 06:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:44 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')]} 06:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:44 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 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:44 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 06:44:44 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 06:44:44 INFO - Using env: {'DISPLAY': ':0', 06:44:44 INFO - 'HOME': '/home/cltbld', 06:44:44 INFO - 'LANG': 'en_US.UTF-8', 06:44:44 INFO - 'LANGUAGE': 'en_US:en', 06:44:44 INFO - 'LOGNAME': 'cltbld', 06:44:44 INFO - 'MAIL': '/var/mail/cltbld', 06:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:44 INFO - 'MOZ_NO_REMOTE': '1', 06:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:44 INFO - 'NO_EM_RESTART': '1', 06:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:44 INFO - 'PWD': '/builds/slave/test', 06:44:44 INFO - 'SHELL': '/bin/bash', 06:44:44 INFO - 'SHLVL': '1', 06:44:44 INFO - 'TERM': 'linux', 06:44:44 INFO - 'TMOUT': '86400', 06:44:44 INFO - 'USER': 'cltbld', 06:44:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:44 INFO - '_': '/tools/buildbot/bin/python'} 06:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:46 INFO - Installing collected packages: mozsystemmonitor 06:44:46 INFO - Running setup.py install for mozsystemmonitor 06:44:46 INFO - Successfully installed mozsystemmonitor 06:44:46 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:44:46 INFO - Using env: {'DISPLAY': ':0', 06:44:46 INFO - 'HOME': '/home/cltbld', 06:44:46 INFO - 'LANG': 'en_US.UTF-8', 06:44:46 INFO - 'LANGUAGE': 'en_US:en', 06:44:46 INFO - 'LOGNAME': 'cltbld', 06:44:46 INFO - 'MAIL': '/var/mail/cltbld', 06:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:46 INFO - 'MOZ_NO_REMOTE': '1', 06:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:46 INFO - 'NO_EM_RESTART': '1', 06:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:46 INFO - 'PWD': '/builds/slave/test', 06:44:46 INFO - 'SHELL': '/bin/bash', 06:44:46 INFO - 'SHLVL': '1', 06:44:46 INFO - 'TERM': 'linux', 06:44:46 INFO - 'TMOUT': '86400', 06:44:46 INFO - 'USER': 'cltbld', 06:44:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:46 INFO - '_': '/tools/buildbot/bin/python'} 06:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 INFO - Downloading docopt-0.6.1.tar.gz 06:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:49 INFO - Running setup.py install for blobuploader 06:44:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:49 INFO - Running setup.py install for requests 06:44:50 INFO - Running setup.py install for docopt 06:44:50 INFO - Successfully installed blobuploader requests docopt 06:44:50 INFO - Cleaning up... 06:44:50 INFO - Return code: 0 06:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:50 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 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:50 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 06:44:50 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 06:44:50 INFO - Using env: {'DISPLAY': ':0', 06:44:50 INFO - 'HOME': '/home/cltbld', 06:44:50 INFO - 'LANG': 'en_US.UTF-8', 06:44:50 INFO - 'LANGUAGE': 'en_US:en', 06:44:50 INFO - 'LOGNAME': 'cltbld', 06:44:50 INFO - 'MAIL': '/var/mail/cltbld', 06:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:50 INFO - 'MOZ_NO_REMOTE': '1', 06:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:50 INFO - 'NO_EM_RESTART': '1', 06:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:50 INFO - 'PWD': '/builds/slave/test', 06:44:50 INFO - 'SHELL': '/bin/bash', 06:44:50 INFO - 'SHLVL': '1', 06:44:50 INFO - 'TERM': 'linux', 06:44:50 INFO - 'TMOUT': '86400', 06:44:50 INFO - 'USER': 'cltbld', 06:44:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:50 INFO - '_': '/tools/buildbot/bin/python'} 06:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:50 INFO - Running setup.py (path:/tmp/pip-WUG_Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:50 INFO - Running setup.py (path:/tmp/pip-CFJ_GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:50 INFO - Running setup.py (path:/tmp/pip-L8_QxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:50 INFO - Running setup.py (path:/tmp/pip-qsfLsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:50 INFO - Running setup.py (path:/tmp/pip-2h0gTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:51 INFO - Running setup.py (path:/tmp/pip-AHqtXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:51 INFO - Running setup.py (path:/tmp/pip-nAW74A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:51 INFO - Running setup.py (path:/tmp/pip-KZCSlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:51 INFO - Running setup.py (path:/tmp/pip-WQpUTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:51 INFO - Running setup.py (path:/tmp/pip-KFh81s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:51 INFO - Running setup.py (path:/tmp/pip-iEzyjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:51 INFO - Running setup.py (path:/tmp/pip-XSRvjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:51 INFO - Running setup.py (path:/tmp/pip-fdNu6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:51 INFO - Running setup.py (path:/tmp/pip-bQCdNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:51 INFO - Running setup.py (path:/tmp/pip-wRlGO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:51 INFO - Running setup.py (path:/tmp/pip-L_v1t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:51 INFO - Running setup.py (path:/tmp/pip-R1BviZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:51 INFO - Running setup.py install for manifestparser 06:44:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for mozcrash 06:44:52 INFO - Running setup.py install for mozdebug 06:44:52 INFO - Running setup.py install for mozdevice 06:44:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for mozfile 06:44:52 INFO - Running setup.py install for mozhttpd 06:44:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for mozinfo 06:44:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for mozInstall 06:44:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for mozleak 06:44:52 INFO - Running setup.py install for mozlog 06:44:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Running setup.py install for moznetwork 06:44:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Running setup.py install for mozprocess 06:44:53 INFO - Running setup.py install for mozprofile 06:44:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Running setup.py install for mozrunner 06:44:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Running setup.py install for mozscreenshot 06:44:53 INFO - Running setup.py install for moztest 06:44:53 INFO - Running setup.py install for mozversion 06:44:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:53 INFO - Cleaning up... 06:44:53 INFO - Return code: 0 06:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:53 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 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:53 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 06:44:53 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 06:44:53 INFO - Using env: {'DISPLAY': ':0', 06:44:53 INFO - 'HOME': '/home/cltbld', 06:44:53 INFO - 'LANG': 'en_US.UTF-8', 06:44:53 INFO - 'LANGUAGE': 'en_US:en', 06:44:53 INFO - 'LOGNAME': 'cltbld', 06:44:53 INFO - 'MAIL': '/var/mail/cltbld', 06:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:53 INFO - 'MOZ_NO_REMOTE': '1', 06:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:53 INFO - 'NO_EM_RESTART': '1', 06:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:53 INFO - 'PWD': '/builds/slave/test', 06:44:53 INFO - 'SHELL': '/bin/bash', 06:44:53 INFO - 'SHLVL': '1', 06:44:53 INFO - 'TERM': 'linux', 06:44:53 INFO - 'TMOUT': '86400', 06:44:53 INFO - 'USER': 'cltbld', 06:44:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:53 INFO - '_': '/tools/buildbot/bin/python'} 06:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:53 INFO - Running setup.py (path:/tmp/pip-AdX5eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:53 INFO - Running setup.py (path:/tmp/pip-jeuArW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:54 INFO - Running setup.py (path:/tmp/pip-lV0cY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:54 INFO - Running setup.py (path:/tmp/pip-tDSKxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:54 INFO - Running setup.py (path:/tmp/pip-BNqCNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:54 INFO - Running setup.py (path:/tmp/pip-R9k9Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:54 INFO - Running setup.py (path:/tmp/pip-Jdet6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:54 INFO - Running setup.py (path:/tmp/pip-c0hl_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:54 INFO - Running setup.py (path:/tmp/pip-FCUGtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:54 INFO - Running setup.py (path:/tmp/pip-63VOCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:54 INFO - Running setup.py (path:/tmp/pip-o_BSYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:54 INFO - Running setup.py (path:/tmp/pip-ZTwSxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:54 INFO - Running setup.py (path:/tmp/pip-miRV1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:54 INFO - Running setup.py (path:/tmp/pip-57UFZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:54 INFO - Running setup.py (path:/tmp/pip-2_HwvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:54 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)) 06:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:54 INFO - Running setup.py (path:/tmp/pip-AUl8ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:55 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)) 06:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:55 INFO - Running setup.py (path:/tmp/pip-PJ2db6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:55 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 06:44:55 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 06:44:55 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 06:44:55 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 06:44:55 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 06:44:55 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 06:44:57 INFO - Downloading blessings-1.6.tar.gz 06:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:57 INFO - Installing collected packages: blessings 06:44:57 INFO - Running setup.py install for blessings 06:44:57 INFO - Successfully installed blessings 06:44:57 INFO - Cleaning up... 06:44:57 INFO - Return code: 0 06:44:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:57 INFO - Reading from file tmpfile_stdout 06:44:57 INFO - Current package versions: 06:44:57 INFO - argparse == 1.2.1 06:44:57 INFO - blessings == 1.6 06:44:57 INFO - blobuploader == 1.2.4 06:44:57 INFO - docopt == 0.6.1 06:44:57 INFO - manifestparser == 1.1 06:44:57 INFO - mozInstall == 1.12 06:44:57 INFO - mozcrash == 0.17 06:44:57 INFO - mozdebug == 0.1 06:44:57 INFO - mozdevice == 0.48 06:44:57 INFO - mozfile == 1.2 06:44:57 INFO - mozhttpd == 0.7 06:44:57 INFO - mozinfo == 0.9 06:44:57 INFO - mozleak == 0.1 06:44:57 INFO - mozlog == 3.2 06:44:57 INFO - moznetwork == 0.27 06:44:57 INFO - mozprocess == 0.22 06:44:57 INFO - mozprofile == 0.28 06:44:57 INFO - mozrunner == 6.11 06:44:57 INFO - mozscreenshot == 0.1 06:44:57 INFO - mozsystemmonitor == 0.3 06:44:57 INFO - moztest == 0.7 06:44:57 INFO - mozversion == 1.4 06:44:57 INFO - psutil == 3.1.1 06:44:57 INFO - requests == 1.2.3 06:44:57 INFO - wsgiref == 0.1.2 06:44:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:57 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 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:57 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 06:44:57 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 06:44:57 INFO - Using env: {'DISPLAY': ':0', 06:44:57 INFO - 'HOME': '/home/cltbld', 06:44:57 INFO - 'LANG': 'en_US.UTF-8', 06:44:57 INFO - 'LANGUAGE': 'en_US:en', 06:44:57 INFO - 'LOGNAME': 'cltbld', 06:44:57 INFO - 'MAIL': '/var/mail/cltbld', 06:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:57 INFO - 'MOZ_NO_REMOTE': '1', 06:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:57 INFO - 'NO_EM_RESTART': '1', 06:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:57 INFO - 'PWD': '/builds/slave/test', 06:44:57 INFO - 'SHELL': '/bin/bash', 06:44:57 INFO - 'SHLVL': '1', 06:44:57 INFO - 'TERM': 'linux', 06:44:57 INFO - 'TMOUT': '86400', 06:44:57 INFO - 'USER': 'cltbld', 06:44:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:57 INFO - '_': '/tools/buildbot/bin/python'} 06:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 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)) 06:44:57 INFO - Cleaning up... 06:44:57 INFO - Return code: 0 06:44:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:44:57 INFO - Using env: {'DISPLAY': ':0', 06:44:57 INFO - 'HOME': '/home/cltbld', 06:44:57 INFO - 'LANG': 'en_US.UTF-8', 06:44:57 INFO - 'LANGUAGE': 'en_US:en', 06:44:57 INFO - 'LOGNAME': 'cltbld', 06:44:57 INFO - 'MAIL': '/var/mail/cltbld', 06:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:57 INFO - 'MOZ_NO_REMOTE': '1', 06:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:57 INFO - 'NO_EM_RESTART': '1', 06:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:57 INFO - 'PWD': '/builds/slave/test', 06:44:57 INFO - 'SHELL': '/bin/bash', 06:44:57 INFO - 'SHLVL': '1', 06:44:57 INFO - 'TERM': 'linux', 06:44:57 INFO - 'TMOUT': '86400', 06:44:57 INFO - 'USER': 'cltbld', 06:44:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:57 INFO - '_': '/tools/buildbot/bin/python'} 06:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:57 INFO - Downloading/unpacking jsonschema 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:59 INFO - Downloading/unpacking functools32 (from jsonschema) 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:45:00 INFO - warning: no files found matching '*.txt' 06:45:00 INFO - no previously-included directories found matching 'build' 06:45:00 INFO - no previously-included directories found matching 'dist' 06:45:00 INFO - no previously-included directories found matching '.git*' 06:45:00 INFO - Installing collected packages: jsonschema, functools32 06:45:00 INFO - Running setup.py install for functools32 06:45:00 INFO - warning: no files found matching '*.txt' 06:45:00 INFO - no previously-included directories found matching 'build' 06:45:00 INFO - no previously-included directories found matching 'dist' 06:45:00 INFO - no previously-included directories found matching '.git*' 06:45:00 INFO - Successfully installed jsonschema functools32 06:45:00 INFO - Cleaning up... 06:45:00 INFO - Return code: 0 06:45:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f264a523f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, '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': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', '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 06:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:45:00 INFO - Using env: {'DISPLAY': ':0', 06:45:00 INFO - 'HOME': '/home/cltbld', 06:45:00 INFO - 'LANG': 'en_US.UTF-8', 06:45:00 INFO - 'LANGUAGE': 'en_US:en', 06:45:00 INFO - 'LOGNAME': 'cltbld', 06:45:00 INFO - 'MAIL': '/var/mail/cltbld', 06:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:00 INFO - 'MOZ_NO_REMOTE': '1', 06:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:00 INFO - 'NO_EM_RESTART': '1', 06:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:00 INFO - 'PWD': '/builds/slave/test', 06:45:00 INFO - 'SHELL': '/bin/bash', 06:45:00 INFO - 'SHLVL': '1', 06:45:00 INFO - 'TERM': 'linux', 06:45:00 INFO - 'TMOUT': '86400', 06:45:00 INFO - 'USER': 'cltbld', 06:45:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:00 INFO - '_': '/tools/buildbot/bin/python'} 06:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:00 INFO - Downloading/unpacking flake8 06:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:45:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:45:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:45:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:45:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:45:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:45:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:45:03 INFO - no previously-included directories found matching 'docs/_build' 06:45:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:45:03 INFO - Running setup.py install for pep8 06:45:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:45:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:45:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:45:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:45:03 INFO - no previously-included directories found matching 'docs/_build' 06:45:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:45:03 INFO - Cleaning up... 06:45:03 INFO - Return code: 0 06:45:03 INFO - Running post-action listener: _resource_record_post_action 06:45:03 INFO - Running post-action listener: _start_resource_monitoring 06:45:03 INFO - Starting resource monitoring. 06:45:03 INFO - ##### 06:45:03 INFO - ##### Finished create-virtualenv step (success) 06:45:03 INFO - ##### 06:45:03 INFO - ##### 06:45:03 INFO - ##### Running install step. 06:45:03 INFO - ##### 06:45:03 INFO - Running pre-action listener: _resource_record_pre_action 06:45:03 INFO - Running main action method: install 06:45:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:03 INFO - Reading from file tmpfile_stdout 06:45:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:03 INFO - Reading from file tmpfile_stdout 06:45:03 INFO - Output received: 06:45:03 INFO - Usage: mozinstall [options] installer 06:45:03 INFO - Options: 06:45:03 INFO - -h, --help show this help message and exit 06:45:03 INFO - -d DEST, --destination=DEST 06:45:03 INFO - Directory to install application into. [default: 06:45:03 INFO - "/builds/slave/test"] 06:45:03 INFO - --app=APP Application being installed. [default: firefox] 06:45:03 INFO - mkdir: /builds/slave/test/build/application 06:45:03 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'] 06:45:03 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 06:45:19 INFO - Reading from file tmpfile_stdout 06:45:19 INFO - Output received: 06:45:19 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:19 INFO - Running post-action listener: _resource_record_post_action 06:45:19 INFO - ##### 06:45:19 INFO - ##### Finished install step (success) 06:45:19 INFO - ##### 06:45:19 INFO - ##### 06:45:19 INFO - ##### Running run-tests step. 06:45:19 INFO - ##### 06:45:19 INFO - Running pre-action listener: _resource_record_pre_action 06:45:19 INFO - Running main action method: run_tests 06:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:19 INFO - Python 2.7.3 06:45:19 INFO - Return code: 0 06:45:19 INFO - grabbing minidump binary from tooltool 06:45: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')]} 06:45:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f9c0>, '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 0x26708c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2670d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:45:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:45:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:45:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:19 INFO - Return code: 0 06:45:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:45:20 INFO - Return code: 0 06:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 06:45:20 INFO - Using env: {'DISPLAY': ':0', 06:45:20 INFO - 'HOME': '/home/cltbld', 06:45:20 INFO - 'LANG': 'en_US.UTF-8', 06:45:20 INFO - 'LANGUAGE': 'en_US:en', 06:45:20 INFO - 'LOGNAME': 'cltbld', 06:45:20 INFO - 'MAIL': '/var/mail/cltbld', 06:45:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:20 INFO - 'MOZ_NO_REMOTE': '1', 06:45:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:20 INFO - 'NO_EM_RESTART': '1', 06:45:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:20 INFO - 'PWD': '/builds/slave/test', 06:45:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:20 INFO - 'SHELL': '/bin/bash', 06:45:20 INFO - 'SHLVL': '1', 06:45:20 INFO - 'TERM': 'linux', 06:45:20 INFO - 'TMOUT': '86400', 06:45:20 INFO - 'USER': 'cltbld', 06:45:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464701328.856026-920692429', 06:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:20 INFO - '_': '/tools/buildbot/bin/python'} 06:45:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:45:21 INFO - mozversion application_buildid: 20160531053439 06:45:21 INFO - mozversion application_changeset: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa 06:45:21 INFO - mozversion application_display_name: Nightly 06:45:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:21 INFO - mozversion application_name: Firefox 06:45:21 INFO - mozversion application_remotingname: firefox 06:45:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:45:21 INFO - mozversion application_vendor: Mozilla 06:45:21 INFO - mozversion application_version: 49.0a1 06:45:21 INFO - mozversion platform_buildid: 20160531053439 06:45:21 INFO - mozversion platform_changeset: af81ae8922d6a90dc0413bb1c0f8fdf176a628fa 06:45:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:45:21 INFO - mozversion platform_version: 49.0a1 06:45:21 INFO - using testdate: 1464702321 06:45:21 INFO - actual date: 1464702321 06:45:21 INFO - starting webserver on 'localhost:34765' 06:45:21 INFO - SUITE-START | Running 2 tests 06:45:21 INFO - TEST-START | dromaeo_css 06:45:21 INFO - operating with platform_type : linux_ 06:45:21 INFO - Initialising browser for dromaeo_css test... 06:45:21 INFO - TEST-INFO | started process 7230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DuWsV/profile http://localhost:34765/getInfo.html) 06:45:26 INFO - PROCESS | 7230 | __metrics Screen width/height:1600/1200 06:45:26 INFO - PROCESS | 7230 | colorDepth:24 06:45:26 INFO - PROCESS | 7230 | Browser inner width/height: 1024/697 06:45:26 INFO - PROCESS | 7230 | __metrics 06:45:27 ERROR - PROCESS | 7230 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:45:27 INFO - TEST-INFO | 7230: exit 0 06:45:27 INFO - Browser initialized. 06:45:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:27 INFO - TEST-INFO | started process 7350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DuWsV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:39 INFO - PROCESS | 7350 | RSS: Main: 168632320 06:45:39 INFO - PROCESS | 7350 | 06:46:29 INFO - PROCESS | 7350 | 1464702389557 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] 06:48:41 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34765/tests/dromaeo/cssquery-ext.html) 06:48:42 INFO - PROCESS | 7350 | RSS: Main: 170790912 06:48:42 INFO - PROCESS | 7350 | 06:51:44 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-ext.html (next: http://localhost:34765/tests/dromaeo/cssquery-jquery.html) 06:51:45 INFO - PROCESS | 7350 | RSS: Main: 169717760 06:51:45 INFO - PROCESS | 7350 | 06:54:47 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34765/tests/dromaeo/cssquery-mootools.html) 06:54:47 INFO - PROCESS | 7350 | RSS: Main: 171610112 06:54:47 INFO - PROCESS | 7350 | 06:57:49 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34765/tests/dromaeo/cssquery-prototype.html) 06:57:50 INFO - PROCESS | 7350 | RSS: Main: 168816640 06:57:50 INFO - PROCESS | 7350 | 07:00:52 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34765/tests/dromaeo/cssquery-yui.html) 07:00:53 INFO - PROCESS | 7350 | RSS: Main: 171061248 07:00:53 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | Cycle 1(1): loaded http://localhost:34765/tests/dromaeo/cssquery-yui.html (next: http://localhost:34765/tests/dromaeo/cssquery-dojo.html) 07:03:56 INFO - PROCESS | 7350 | RSS: Main: 171937792 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | __start_tp_report 07:03:56 INFO - PROCESS | 7350 | _x_x_mozilla_page_load 07:03:56 INFO - PROCESS | 7350 | _x_x_mozilla_page_load_details 07:03:56 INFO - PROCESS | 7350 | |i|pagename|runs| 07:03:56 INFO - PROCESS | 7350 | |0;dojo.html;2646.1796842978674;2685.8522781247025;2685.932851678709;2699.946001079978;2725.6729192496905;4578.15304168729;4699.85900422987;4729.361536192618;4767.6424268179935;4826.782794774234;4631.583157515823;4700.717956922587;4727.267273572602;4729.716217026981;4735.573798358147;4322.416473776039;4343.78281085946;4404.691671582975;4457.153140903234;4468.932966005496;4143.254214241435;4500.0774841157645;4512.9097418051615;4527.049319642879;4561.384213131235;4258.616724494779;4298.226319262531;4301.075268817188;4343.066240758237;4392.934105988413;4286.335617979218;4288.957110428887;4295.205387003414;4324.264874971231;4374.431323927901;4370.38814565961;4372.519022907478;4374.212641724488;4379.4525684289465;4411.139827733593;4627.884302892455;4665.370175026396;4666.95333046672;4668.626509879202;4677.368555245066;5107.13178759608;5126.487351264844;5137.897242055138;5139.974300128475;5168.61235407346;5026.170681837529;5149.588032957355;5167.224916262553;5173.948260517384;5176.637635365526;4712.929306060412;4747.8575642730775;4753.382060332135;4759.048190361941;4806.735629540409;5187.144121219956;5190.273361729361;5193.350831146106;5194.142966410575;5198.6880787152895;4829.9275510867365;4870.245112007645;4880.829170978998;4963;5033.723145227048;5031.496850314939;5036.597072234213;5044.772985215674;5055.620828437882;5079.873003174876;4849.248366503198;4989.850304490871;5072.771725272371;5083.415407228142;5126.282320475137;4866.878328041827;4906.754662266872;5053.216751403538;5058.190689489664;5080.669756465818;4156.085661154541;4172.165566886635;4184.225918205142;4219.810108545062;4224.4930608327195;3666.74332796707;3672.944905826415;3693.150575367627;3699.4820725098507;3716.089558058293;4272.230998420252;4344.348347747863;4349.717268377545;4383.912321753547;4415.51429342772;5136.512031357015;5157.484251574812;5173.456787037382;5185.248139019821;5230.450802665665;4430.579094985971;4434.800433980478;4438.400815889813;4443.230085198379;4481.663875209372;4373.190959672471;4458.71018383804;4486.304622783474;4555.703879247838;4602.171609110325;4840.467548569584;4866.853994380174;4869.366982292279;4880.243562247857;4903.53416425439;5078.619103567321;5093.337866077386;5105.795768169231;5123.052235336475;5135.2553879687985;4705.670603057753;4829.903401932012;4836.347093142381;4879.219324907997;4891.877703057452;5078.97460512695;5093.159628661378;5103.668261562986;5114.232865070269;5156.819511317086;5116.130257856248;5119.74401279927;5144.948550514597;5145.974270128625;5189.273501709839;4803.423589169322;4821.9035619288115;4937.456879743298;4972.204447288416;4977.576905963034;4889.339939108175;4903.04390643821;4912.803487860446;4934.901301973869;4971.776270067928;4857.6599638025;4863.124637565272;4885.755712214446;4906.607471402351;4949.604031677385;4836.46798852119;4933.975330123327;4963.478834722302;4986;4996.150654388835;4848.817483285073;4900.828471003498;4911.115999120193;4915.0415668944215;4963 07:03:56 INFO - PROCESS | 7350 | |1;ext.html;544.5398638150764;599.4305409860633;603.5051257968465;620.9937900620995;626.5175814622738;34922.30155396891;39475.407868881986;39571.60428395715;39625.801870990676;39655.80172099135;40437.59562404375;41256.793716031454;41650.54223102192;41744.58255417452;41765.37351939723;7609.8478030439355;7719.575423351714;7764.572948487831;7811.687532498693;7841.921580784205;7702.383809295243;7796.41526885483;7805.492642978216;7807.219278072176;7809.375249980017;7759.6120193990355;7782.416318776086;7784.494007889469;7808.843823123534;7835.490693104958;7633.694652213905;7790.883136752953;7794.376449884024;7798.883016754753;7827.9608601956625;7455.105387353552;7541;7577.621118944031;7600.733974310928;7611.885821712679;29964;37119.25761484782;37472.063198419986;37517.624823751685;37854.43218351727;3019.6376434827744;3139.262273365757;3185.888493902702;3222.7099561039386;3709.443583462475;27342.316442088908;30718.232044199074;31511;31589.84205078983;32189.83905080483;3133.1697100268448;3143.072793525915;3182.3317103408313;3213.662565430643;3222.242772948355;267579;272864;273236;274201;274743;29388.7061129386;30207.489625519076;57457.425425745205;57738.42261577331;57930.710346447995;35087.82456087754;35214.29571408609;35306.64693353085;35322.64677353194;35472.11319716976;12785.488580456864;12879.291638959947;12985.740285194432;13050.477980880658;13062.085654004128;10817;10820.458977051116;10879.673609791718;10931.672049838518;10967.451627418597;8116.350691944748;8116.75649730509;8156.714514991947;8211.425200235926;8267.214614611603;3161.8419079046416;3235.320582677617;3238.0609623209007;3280.721138703237;3287.9342413151603;890.643742502991;927.6224806162843;1046.2937517176028;1068.1454836131063;1080.502968634437;28422;28425.078132020797;28535.57196642052;28910.85544572264;28919.277018074717;948.1135138645388;1023.5905637744961;1048.250500891866;1055.3562326980536;1127.3517727306833;14898.478553250585;15250.703690186458;15286.541403757905;15459.227038648023;15463.84536154624;408412;410898;413269;413499;414896;51289;51557;51875.74062129665;52071.21893171605;52137.2179417309;1189.251450876926;1211.4064108586906;1218.3360068762368;1232.7287996640725;1243.664210663116;26864.59703104416;27827.16518504448;28241.446720430573;28246.85876570604;28398;37798;37997.620023799405;38119.42820857745;38291.6170838288;38314.23371532498;316780;319318;319858;320437;320523;22945.65581516312;23491;25901.22296331113;26226.73773262243;26294.4741105173;42878;43747;43922.90192745207;44277;44416;37165;37342.253154937294;37348.43977340397;37603.62396376111;37790.62209377981;36694.44958325574;36768;36788.816055919546;36803.631963681095;36947.44578831266;31929.36141277208;36096.63903361038;36317.45523817092;39376.803115984236;39768.403473947335;32723.836380817942;33525.66474335225;33885;34230.31539369249;34341.48487772735;26032.609510857732;26076.217713467868;26103.869480652476;26346.73653263443;26552.78963996855 07:03:56 INFO - PROCESS | 7350 | |2;jquery.html;360.70782666040503;360.83762306961864;368.1036675694682;378.70082634718574;384.33510027652176;15638.765418518717;16786.66426671466;17622;17684.292628294854;17687.911560442197;15948.28232729527;16204.675906481863;16956.0674162921;17049.659006819857;17057.317707291724;5019.749012549367;5198.714070726109;5225.634205605609;5239.056969745444;5256.763445644955;3786.8674596389133;5128.769205385766;5743.712814359286;6062.120992456091;6062.211912451375;6059.363766804466;6070.484008859252;6101.755929762804;6112.8471788205425;6134.4478996890275;5006.173981293082;5336.493033161843;5356.839294821161;5420.783168673248;5433.6196466247375;5010.398752149729;5205.557527610158;5227.738613069369;5244.082285600005;5250.501202385767;11804.291742495392;11996.940015299955;12090.093243006722;12116.81824772629;12415.689607759788;1767.8408943195175;1928.6721257386278;1953.8925359105244;2021.797820217981;2330.7552706965694;8916.554172291424;8962.955185224033;9030.909690903138;9544.284178686627;9547.761305967406;1654.9420770273102;1657.5938894970689;1696.8133505314406;1700.9829901700948;1731.5757639378307;69222;70404.99999999949;71312.99999999948;71334;73520.6323968382;9825.803483930282;10017.749556261006;10117.747056323651;10129.189664826943;10187.286889917783;14028.438862445388;14084.788728169086;14227.64430889236;14281.285935703174;14312.57062288133;7055.8236044098285;7150.356467917913;7164.176119746296;7188.892166617505;7231.7107315707835;6377.298497165308;6522.706478208492;6539.247986481616;6562.80311590653;6728.125343705287;4235.767032813224;4236.385724069993;4323.135372925364;4360.127974405132;4378.693491455568;1645.4158773635188;1700.4728534154451;1748.6327871147203;1789.2574581548772;1797.0385843573886;823.5964377455003;915.8488849339784;922.1562270522531;924.8705181274627;931.5761328595473;14226.928865355814;15548.455804046804;15944.123073230852;16373.672526549402;16544.50366489007;836.9288610468178;869.8434281829332;891.6834523744108;898.2006014646969;902.0798785239019;9000.819983600291;9291.396059256127;9413.529323533796;9431.952840235756;9442.90557094434;359927;396602;397618;397967;402460;47417.28874066892;69308;76198.61900690461;76681;76985.23014769892;919.2783664823215;920.4017388697266;920.5305294299956;943.9008904065112;945.8392073347547;14405.207713575435;14597.408020520894;14721.411143554138;14739.778903316244;15162.090274583119;33460.83269583636;34881.825590871886;36809.44785828161;37767.24465510729;38075.428868566436;45619.54380456153;49887;49964.50035499599;50233.74883125561;50284.49715502798;7022.894656580258;7126.109236345457;7175.748848790267;7211.3870321023305;7232.240614735588;7032.718691252293;7937.325327347009;9640.614375425184;10180.847287290844;10555.683329500127;4695.6243500519195;4850.53919877611;9070.863937041082;9237.89145302568;9715.805683886425;9298.302627302844;9317;9377.484238366682;9690.612375504901;9794.951025245113;9472.194863436409;9817.263705221994;9960.306747852737;9980.051895069957;10028.147607453448;6931.480138989495;6986.650667466504;7088.0785497884945;7095.822604434724;7096.8935465967015;9006.234470069856;9359.906400936175;9422.764430889009;9642.855357169788;9843.507824608883 07:03:56 INFO - PROCESS | 7350 | |3;mootools.html;1432.4986254810817;1462.5319897632758;1591.6657501924594;1750.7373893915903;1779.5906941403478;6882.380585747282;7518;7549.584772837492;8146.91853081469;8147.755567332974;7582.962085189566;7714.112877019144;7742.883856742139;7765.844683106335;7802.453828232026;2119.1205649655412;2157.892105394732;2158.935231943044;2160.643493823525;2165.65349544073;2027.523531969986;2053.9216911121707;2121.469632591852;2127.308624696972;2129.6166689995794;2101.05452546354;2104.463361842728;2122.766495685481;2127.425595089325;2163.826893848496;2092.2990798082583;2098.244631932503;2101.8423618228617;2104.2635077722825;2115.3548167808813;2070.8653937494164;2119.6608542633257;2135.1672847589452;2151.9784802151935;2164.4805246740825;7503.474756767028;7560.659770310349;7566.394688424913;7586.886196707053;7656.923430765677;4532.456105267389;4555.293929440909;4597.149527337453;4602.838900638495;4603.378543896564;2742.7120152383914;2871.267826704198;2948.882044718209;2959.4672958867395;2959.7632189424794;834.0491839303139;863.5466380150408;881.3037700216821;888.6889588643922;900.333753022765;10944.3980581068;10983.340999540053;11045.613403530839;11054.889451105466;11064.391458469781;4201.537830838605;4252.702310838212;4327.56724327571;4341.153475072394;4344.978275108604;9298.209652179505;9321.72034838956;9348.57931393089;9389.248860091177;9400.670976515788;4535.682502224812;4563.133004729158;4576.359309696645;4600.378948841931;4632.2125238709505;3669.302832461877;4072.857449989236;4189.727667701651;4203.684723645739;4231.61915427613;3696.334659761215;3698.7965661888857;3789.8105094745706;3791.1280405506886;3820.2741479119436;1159.7448561316496;1191.338083373689;1214.7023979124995;1215.465195314059;1217.817327400897;796.4783067091065;833.5623797506237;898.1467605774541;905.6467977488785;912.333996182777;5385.6230063895155;5468.863278418072;5534.889302214014;5582.888342233133;5667.348254950651;815.6615004773072;835.7367429259764;871.3203701113142;893.5487578772678;908.2280061947292;3927.3127202739406;3931.803409829497;4002.639762421396;4009.498812648419;4023.1752490739914;9237.90762092384;9562.426254424758;9660.130588247092;9894.802103958025;9917.15704165154;9742.366746161477;9824.11582957523;9829.508524573743;9834;9860.852087218698;7318.377937875341;7484.101907771103;7484.999999999891;7488.326050655467;7506.699732010768;5538.307711536058;5693.3168019837885;5709.058005429224;5774.307083150049;5808.970955145197;8776.868346974928;9057.456552606865;9106.225970792557;9220.585073671567;9303.860442093239;8646.351523635627;9038.960519540336;9053.411528250906;9368.906310936803;9392.342536022414;5872.853178670567;6617.371349721769;6765.797026089225;6843.076184715199;6918.0314755935215;7461.701531938662;7496.812579685551;7527;7536.057992750906;7547.433942454448;6480.773172938924;6658.43403310724;6704.396604305441;6776.6950487227205;6837.863242735018;6404.487640988803;6492.220933488012;6544.934550654432;6598.175228096488;6667.966660166862;6409.935900640934;6453.225612926479;6477.4494167996245;6481.578697384655;6488.416042556192;4675.205215113507;4684.110019096361;4783.904321913473;4785.617150628011;4823.324734537237;4759.881002974953;4851.32081508582;4969.950300496948;4970.105381031304;4974.32846565709 07:03:56 INFO - PROCESS | 7350 | |4;prototype.html;302.6579964639958;302.6595080534399;304.5644728038904;309.4321919278124;310.2383648143806;5043.722595257269;5072.695638261707;5100.030994111125;5107.668001579895;5145.073886700397;4974.8608098517625;4979.203327467606;4979.979104283622;4982.377202849644;4991.875203119924;3744.438334249871;3805.7145714071557;3936.2127574485075;3941.4284928685324;3952.486176797027;3944.605539446047;3980.104476492795;3985.501812273466;3992.740471869319;3997.4403583498333;3924.646781789638;3946.6842652587866;3951.841926322958;3956.8417263309434;3965.762054276738;3759.3797023491366;3915.804209789499;3920.372740361557;3938.1926705025403;3940.0937784309626;3473.8436770345143;3480.112571294329;3483.74585149346;3489.354469423165;3489.8778542751134;4833.709977401332;4862.5380588844;4864.8297309594345;4866.707997520125;4903.26451032348;4436.933445998313;4537.799167403807;4550.340200670884;4575.633949284049;4612.584867361954;5241.292425522543;5255.6583822051825;5258.421573626898;5273.261743355895;5290.39160496544;3784.6404591563755;3807.714421418377;3815.8473661053526;3821.522309711286;3826.1199924017355;5426.782928682848;5535.035062552816;5543.362513310981;5560.36055853578;5569.526590239794;3867.9613203867602;3876.6898648108086;3897.922041559153;3926.312895243321;3928.273269445162;3925.4111883217747;3961.6632586229916;3968.2857085724845;3970.900727481836;3974.423708562242;4467.553244675506;4480.327950807405;4490.618297444754;4500.514830106123;4507.6168525675685;5039.79840806371;5117.8464646060675;5138.691678499302;5209.426963034063;5271.65734227274;1346.6566025663394;1358.151155527795;1361.8501964783866;1377.9862201378057;1381.240317825192;847.186700767258;864.7276108025952;874.4141425245101;881.722257488889;885.8538341173763;4456.732596044248;4506.107434877359;4507.932381014288;4555.954440455619;4559.407277054028;5374.220737992969;5376.193570964387;5379.246905433242;5392.676439413648;5393.919091213635;4374.763054452533;4534.659900507475;4540.931886021713;4542.432195975503;4553.362529245908;2852.657681078284;2877.863244018601;2886.6536015678253;2893.59660564626;2902.242869274198;5084.932164245476;5097.108006098918;5107.182850743938;5124.282600435942;5128.666636668605;5250.107481728115;5532.5297349724915;5548.86127846799;5550.8057217997175;5553.888922221533;5141.331626888556;5150.27896094547;5152.278680984665;5166.560842328369;5192.844214673566;5417.83746487606;5456.399796022513;5462.562994960473;5470.699111548903;5483.396826349178;5193.221016847503;5273.709945953009;5295.152775555893;5313.654612450178;5324.775301680557;5125.79496820123;5131.717755523333;5139.665921715076;5168.733660253262;5173;3729.9254014919006;3734.925301494009;3772.4718539405053;3789.905252368713;3798.6581207691443;5266.605004624592;5447.564194864322;5462.098753705753;5479.232907392889;5553.6390134641115;5262.8947421052135;5296.2320463531805;5297.761600727899;5306.469353064663;5313.246628612471;5217.113090774654;5244.370675518962;5248.396434410091;5268.472143078464;5295.934585511576;4938.678985866051;5182.429932707475;5189.754458929905;5194.558462530727;5211.426743058337;5048.258350868944;5148.536631703165;5286.3568215892055;5301.125314323248;5327.946720532745;5175.275461435327;5186.792528298825;5196.246544251138;5200.5059519345605;5210.843674689765 07:03:56 INFO - PROCESS | 7350 | |5;yui.html;645.5932762359713;656.9375909288616;658.279184293199;684.712420783271;698.53547390985;10600.469976501183;11913.285202887822;12195.451204695788;12227.14409991301;12297.077719171064;11566.07471402288;11625.418729063555;11645.18483706141;11668.35824029678;11916;628.3025841316136;786.1509569664748;790.6205021589641;792.8572856885759;811.3955103447939;800.047942947893;802.2258520527689;802.7993001749562;803.5459965119718;804.2440106300088;837.8156805502811;840.5461051032435;841.0538144587339;841.5960339037266;841.7390608911227;828.5028982610446;830.9210624990616;834.2866848844242;834.9415540912139;835.2816577743137;612.1093808508609;612.6507890502415;616.0758861707438;616.2420223125536;616.552999075671;11981.041516678732;12019.879801201963;12021.759564808743;12022.27866328023;12073.215241009306;12449.257104005446;12585.811212831815;12592.307423091726;12780.569016261847;12926.159799612995;9966.900330996743;10042.397456152654;10065.24510661696;10269.794604107876;10466.162706983423;3239.9352012959607;3258.0877354340587;3273.885414010498;3296.703296703284;3338.565986421774;40235;42271.36592951077;42297.788511057865;45978.54021459776;46222;10020.549075291628;10112.342697724771;10176;10205.285630005978;10373.481325933673;16745;16787.160641967854;16851.325946962228;16886;16891.15544222784;6339.334369891095;6492.443450657836;6816.079829222991;6902.206246281641;6959.547629404073;3733.4026555751493;3798.924021519554;3853.845846166122;3906.160175562211;3975.1652153047607;2825.660920689489;2976.300569366197;3001.5197568388953;3007.3083190866223;3013.6383633964065;607.902735562308;608.7473698415197;610.6366711806468;610.7984365159487;610.8045425463808;486.65204378869277;561.5984571031732;584.3893131677407;585.3268740947944;631.62418361076;8308.5430301334;8376.162383761697;8568.614412351459;8704.95647521771;8712.782180445412;556.834875134;558.9469000444951;614.4040280927493;620.3920158244945;625.6777759453885;3985.80070996449;4018.216447792711;4061.5126184858004;4104;4105.753654780663;57991.420085799444;58510;59498.40501594928;59875.401245986985;59989;53835.73082134564;54111;54875;54877.72561137249;56199.71900140473;50190.498095018585;50961.490385095676;51353.99999999925;51365.486345136815;51449.48550514522;7168.2831716827895;7215.567065976058;7285.817854553678;7313.341799237881;7513.511621744569;33006.33987320192;33591.832040840614;33708.15729606681;34178.82910585431;34668;40031.1993760129;42389.36415953825;44286;44527;44947.550524494334;9503.619855205714;9689.563969621244;9853.16248118918;9863.753406164904;9909.306348555532;10640.574377024832;10735.516901739597;10895.836562451412;11181.776364472827;11330.546778128783;9754.561044753145;10346.689599312032;10471.3193642413;10534.26260161812;10638.361698298128;10222.437765922945;10265.281430300107;10284.177265818567;10356.342436146202;10456.251963164785;9880.50597470138;10196.796064078528;10860.402677852793;10951.123910087334;11037.39294338787;9178.770530736785;9344.906550934676;9381.921079075993;9433.198178154933;9720.562574684014;9124.817503650023;9405.341626086109;9483.525823708926;9548.474833884204;9585.329026968046 07:03:56 INFO - PROCESS | 7350 | __end_tp_report 07:03:56 INFO - PROCESS | 7350 | __start_cc_report 07:03:56 INFO - PROCESS | 7350 | _x_x_mozilla_cycle_collect,385 07:03:56 INFO - PROCESS | 7350 | __end_cc_report 07:03:56 INFO - PROCESS | 7350 | __startTimestamp1464703436274__endTimestamp 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | ------- Summary: start ------- 07:03:56 INFO - PROCESS | 7350 | Number of tests: 6 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#0] dojo.html Cycles:165 Average:4691.65 Median:4840.47 stddev:500.58 (10.3%) stddev-sans-first:475.71 07:03:56 INFO - PROCESS | 7350 | Values: 2646.2 2685.9 2685.9 2699.9 2725.7 4578.2 4699.9 4729.4 4767.6 4826.8 4631.6 4700.7 4727.3 4729.7 4735.6 4322.4 4343.8 4404.7 4457.2 4468.9 4143.3 4500.1 4512.9 4527.0 4561.4 4258.6 4298.2 4301.1 4343.1 4392.9 4286.3 4289.0 4295.2 4324.3 4374.4 4370.4 4372.5 4374.2 4379.5 4411.1 4627.9 4665.4 4667.0 4668.6 4677.4 5107.1 5126.5 5137.9 5140.0 5168.6 5026.2 5149.6 5167.2 5173.9 5176.6 4712.9 4747.9 4753.4 4759.0 4806.7 5187.1 5190.3 5193.4 5194.1 5198.7 4829.9 4870.2 4880.8 4963.0 5033.7 5031.5 5036.6 5044.8 5055.6 5079.9 4849.2 4989.9 5072.8 5083.4 5126.3 4866.9 4906.8 5053.2 5058.2 5080.7 4156.1 4172.2 4184.2 4219.8 4224.5 3666.7 3672.9 3693.2 3699.5 3716.1 4272.2 4344.3 4349.7 4383.9 4415.5 5136.5 5157.5 5173.5 5185.2 5230.5 4430.6 4434.8 4438.4 4443.2 4481.7 4373.2 4458.7 4486.3 4555.7 4602.2 4840.5 4866.9 4869.4 4880.2 4903.5 5078.6 5093.3 5105.8 5123.1 5135.3 4705.7 4829.9 4836.3 4879.2 4891.9 5079.0 5093.2 5103.7 5114.2 5156.8 5116.1 5119.7 5144.9 5146.0 5189.3 4803.4 4821.9 4937.5 4972.2 4977.6 4889.3 4903.0 4912.8 4934.9 4971.8 4857.7 4863.1 4885.8 4906.6 4949.6 4836.5 4934.0 4963.5 4986.0 4996.2 4848.8 4900.8 4911.1 4915.0 4963.0 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#1] ext.html Cycles:180 Average:47729.36 Median:35784.38 stddev:89751.08 (250.8%) stddev-sans-first:89932.94 07:03:56 INFO - PROCESS | 7350 | Values: 544.5 599.4 603.5 621.0 626.5 34922.3 39475.4 39571.6 39625.8 39655.8 40437.6 41256.8 41650.5 41744.6 41765.4 7609.8 7719.6 7764.6 7811.7 7841.9 7702.4 7796.4 7805.5 7807.2 7809.4 7759.6 7782.4 7784.5 7808.8 7835.5 7633.7 7790.9 7794.4 7798.9 7828.0 7455.1 7541.0 7577.6 7600.7 7611.9 29964.0 37119.3 37472.1 37517.6 37854.4 3019.6 3139.3 3185.9 3222.7 3709.4 27342.3 30718.2 31511.0 31589.8 32189.8 3133.2 3143.1 3182.3 3213.7 3222.2 267579.0 272864.0 273236.0 274201.0 274743.0 29388.7 30207.5 57457.4 57738.4 57930.7 35087.8 35214.3 35306.6 35322.6 35472.1 12785.5 12879.3 12985.7 13050.5 13062.1 10817.0 10820.5 10879.7 10931.7 10967.5 8116.4 8116.8 8156.7 8211.4 8267.2 3161.8 3235.3 3238.1 3280.7 3287.9 890.6 927.6 1046.3 1068.1 1080.5 28422.0 28425.1 28535.6 28910.9 28919.3 948.1 1023.6 1048.3 1055.4 1127.4 14898.5 15250.7 15286.5 15459.2 15463.8 408412.0 410898.0 413269.0 413499.0 414896.0 51289.0 51557.0 51875.7 52071.2 52137.2 1189.3 1211.4 1218.3 1232.7 1243.7 26864.6 27827.2 28241.4 28246.9 28398.0 37798.0 37997.6 38119.4 38291.6 38314.2 316780.0 319318.0 319858.0 320437.0 320523.0 22945.7 23491.0 25901.2 26226.7 26294.5 42878.0 43747.0 43922.9 44277.0 44416.0 37165.0 37342.3 37348.4 37603.6 37790.6 36694.4 36768.0 36788.8 36803.6 36947.4 31929.4 36096.6 36317.5 39376.8 39768.4 32723.8 33525.7 33885.0 34230.3 34341.5 26032.6 26076.2 26103.9 26346.7 26552.8 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#2] jquery.html Cycles:180 Average:23584.74 Median:5247.29 stddev:64561.52 (1230.4%) stddev-sans-first:64719.08 07:03:56 INFO - PROCESS | 7350 | Values: 360.7 360.8 368.1 378.7 384.3 15638.8 16786.7 17622.0 17684.3 17687.9 15948.3 16204.7 16956.1 17049.7 17057.3 5019.7 5198.7 5225.6 5239.1 5256.8 3786.9 5128.8 5743.7 6062.1 6062.2 6059.4 6070.5 6101.8 6112.8 6134.4 5006.2 5336.5 5356.8 5420.8 5433.6 5010.4 5205.6 5227.7 5244.1 5250.5 11804.3 11996.9 12090.1 12116.8 12415.7 1767.8 1928.7 1953.9 2021.8 2330.8 8916.6 8963.0 9030.9 9544.3 9547.8 1654.9 1657.6 1696.8 1701.0 1731.6 69222.0 70405.0 71313.0 71334.0 73520.6 9825.8 10017.7 10117.7 10129.2 10187.3 14028.4 14084.8 14227.6 14281.3 14312.6 7055.8 7150.4 7164.2 7188.9 7231.7 6377.3 6522.7 6539.2 6562.8 6728.1 4235.8 4236.4 4323.1 4360.1 4378.7 1645.4 1700.5 1748.6 1789.3 1797.0 823.6 915.8 922.2 924.9 931.6 14226.9 15548.5 15944.1 16373.7 16544.5 836.9 869.8 891.7 898.2 902.1 9000.8 9291.4 9413.5 9432.0 9442.9 359927.0 396602.0 397618.0 397967.0 402460.0 47417.3 69308.0 76198.6 76681.0 76985.2 919.3 920.4 920.5 943.9 945.8 14405.2 14597.4 14721.4 14739.8 15162.1 33460.8 34881.8 36809.4 37767.2 38075.4 45619.5 49887.0 49964.5 50233.7 50284.5 7022.9 7126.1 7175.7 7211.4 7232.2 7032.7 7937.3 9640.6 10180.8 10555.7 4695.6 4850.5 9070.9 9237.9 9715.8 9298.3 9317.0 9377.5 9690.6 9795.0 9472.2 9817.3 9960.3 9980.1 10028.1 6931.5 6986.7 7088.1 7095.8 7096.9 9006.2 9359.9 9422.8 9642.9 9843.5 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#3] mootools.html Cycles:180 Average:5203.06 Median:5680.33 stddev:2915.85 (51.3%) stddev-sans-first:2910.26 07:03:56 INFO - PROCESS | 7350 | Values: 1432.5 1462.5 1591.7 1750.7 1779.6 6882.4 7518.0 7549.6 8146.9 8147.8 7583.0 7714.1 7742.9 7765.8 7802.5 2119.1 2157.9 2158.9 2160.6 2165.7 2027.5 2053.9 2121.5 2127.3 2129.6 2101.1 2104.5 2122.8 2127.4 2163.8 2092.3 2098.2 2101.8 2104.3 2115.4 2070.9 2119.7 2135.2 2152.0 2164.5 7503.5 7560.7 7566.4 7586.9 7656.9 4532.5 4555.3 4597.1 4602.8 4603.4 2742.7 2871.3 2948.9 2959.5 2959.8 834.0 863.5 881.3 888.7 900.3 10944.4 10983.3 11045.6 11054.9 11064.4 4201.5 4252.7 4327.6 4341.2 4345.0 9298.2 9321.7 9348.6 9389.2 9400.7 4535.7 4563.1 4576.4 4600.4 4632.2 3669.3 4072.9 4189.7 4203.7 4231.6 3696.3 3698.8 3789.8 3791.1 3820.3 1159.7 1191.3 1214.7 1215.5 1217.8 796.5 833.6 898.1 905.6 912.3 5385.6 5468.9 5534.9 5582.9 5667.3 815.7 835.7 871.3 893.5 908.2 3927.3 3931.8 4002.6 4009.5 4023.2 9237.9 9562.4 9660.1 9894.8 9917.2 9742.4 9824.1 9829.5 9834.0 9860.9 7318.4 7484.1 7485.0 7488.3 7506.7 5538.3 5693.3 5709.1 5774.3 5809.0 8776.9 9057.5 9106.2 9220.6 9303.9 8646.4 9039.0 9053.4 9368.9 9392.3 5872.9 6617.4 6765.8 6843.1 6918.0 7461.7 7496.8 7527.0 7536.1 7547.4 6480.8 6658.4 6704.4 6776.7 6837.9 6404.5 6492.2 6544.9 6598.2 6668.0 6409.9 6453.2 6477.4 6481.6 6488.4 4675.2 4684.1 4783.9 4785.6 4823.3 4759.9 4851.3 4970.0 4970.1 4974.3 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#4] prototype.html Cycles:180 Average:4376.88 Median:5015.84 stddev:1268.19 (25.3%) stddev-sans-first:1234.33 07:03:56 INFO - PROCESS | 7350 | Values: 302.7 302.7 304.6 309.4 310.2 5043.7 5072.7 5100.0 5107.7 5145.1 4974.9 4979.2 4980.0 4982.4 4991.9 3744.4 3805.7 3936.2 3941.4 3952.5 3944.6 3980.1 3985.5 3992.7 3997.4 3924.6 3946.7 3951.8 3956.8 3965.8 3759.4 3915.8 3920.4 3938.2 3940.1 3473.8 3480.1 3483.7 3489.4 3489.9 4833.7 4862.5 4864.8 4866.7 4903.3 4436.9 4537.8 4550.3 4575.6 4612.6 5241.3 5255.7 5258.4 5273.3 5290.4 3784.6 3807.7 3815.8 3821.5 3826.1 5426.8 5535.0 5543.4 5560.4 5569.5 3868.0 3876.7 3897.9 3926.3 3928.3 3925.4 3961.7 3968.3 3970.9 3974.4 4467.6 4480.3 4490.6 4500.5 4507.6 5039.8 5117.8 5138.7 5209.4 5271.7 1346.7 1358.2 1361.9 1378.0 1381.2 847.2 864.7 874.4 881.7 885.9 4456.7 4506.1 4507.9 4556.0 4559.4 5374.2 5376.2 5379.2 5392.7 5393.9 4374.8 4534.7 4540.9 4542.4 4553.4 2852.7 2877.9 2886.7 2893.6 2902.2 5084.9 5097.1 5107.2 5124.3 5128.7 5250.1 5532.5 5548.9 5550.8 5553.9 5141.3 5150.3 5152.3 5166.6 5192.8 5417.8 5456.4 5462.6 5470.7 5483.4 5193.2 5273.7 5295.2 5313.7 5324.8 5125.8 5131.7 5139.7 5168.7 5173.0 3729.9 3734.9 3772.5 3789.9 3798.7 5266.6 5447.6 5462.1 5479.2 5553.6 5262.9 5296.2 5297.8 5306.5 5313.2 5217.1 5244.4 5248.4 5268.5 5295.9 4938.7 5182.4 5189.8 5194.6 5211.4 5048.3 5148.5 5286.4 5301.1 5327.9 5175.3 5186.8 5196.2 5200.5 5210.8 07:03:56 INFO - PROCESS | 7350 | 07:03:56 INFO - PROCESS | 7350 | [#5] yui.html Cycles:180 Average:13463.27 Median:51359.74 stddev:16299.03 (31.7%) stddev-sans-first:16316.33 07:03:56 INFO - PROCESS | 7350 | Values: 645.6 656.9 658.3 684.7 698.5 10600.5 11913.3 12195.5 12227.1 12297.1 11566.1 11625.4 11645.2 11668.4 11916.0 628.3 786.2 790.6 792.9 811.4 800.0 802.2 802.8 803.5 804.2 837.8 840.5 841.1 841.6 841.7 828.5 830.9 834.3 834.9 835.3 612.1 612.7 616.1 616.2 616.6 11981.0 12019.9 12021.8 12022.3 12073.2 12449.3 12585.8 12592.3 12780.6 12926.2 9966.9 10042.4 10065.2 10269.8 10466.2 3239.9 3258.1 3273.9 3296.7 3338.6 40235.0 42271.4 42297.8 45978.5 46222.0 10020.5 10112.3 10176.0 10205.3 10373.5 16745.0 16787.2 16851.3 16886.0 16891.2 6339.3 6492.4 6816.1 6902.2 6959.5 3733.4 3798.9 3853.8 3906.2 3975.2 2825.7 2976.3 3001.5 3007.3 3013.6 607.9 608.7 610.6 610.8 610.8 486.7 561.6 584.4 585.3 631.6 8308.5 8376.2 8568.6 8705.0 8712.8 556.8 558.9 614.4 620.4 625.7 3985.8 4018.2 4061.5 4104.0 4105.8 57991.4 58510.0 59498.4 59875.4 59989.0 53835.7 54111.0 54875.0 54877.7 56199.7 50190.5 50961.5 51354.0 51365.5 51449.5 7168.3 7215.6 7285.8 7313.3 7513.5 33006.3 33591.8 33708.2 34178.8 34668.0 40031.2 42389.4 44286.0 44527.0 44947.6 9503.6 9689.6 9853.2 9863.8 9909.3 10640.6 10735.5 10895.8 11181.8 11330.5 9754.6 10346.7 10471.3 10534.3 10638.4 10222.4 10265.3 10284.2 10356.3 10456.3 9880.5 10196.8 10860.4 10951.1 11037.4 9178.8 9344.9 9381.9 9433.2 9720.6 9124.8 9405.3 9483.5 9548.5 9585.3 07:03:56 INFO - PROCESS | 7350 | -------- Summary: end -------- 07:03:56 INFO - PROCESS | 7350 | 07:03:57 INFO - TEST-INFO | 7350: exit 0 07:03:57 INFO - TEST-OK | dromaeo_css | took 1116044ms 07:03:57 INFO - TEST-START | kraken 07:03:57 INFO - operating with platform_type : linux_ 07:03:57 INFO - Initialising browser for kraken test... 07:03:57 INFO - TEST-INFO | started process 7586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjkf_A/profile http://localhost:34765/getInfo.html) 07:04:02 INFO - PROCESS | 7586 | __metrics Screen width/height:1600/1200 07:04:02 INFO - PROCESS | 7586 | colorDepth:24 07:04:02 INFO - PROCESS | 7586 | Browser inner width/height: 1024/697 07:04:02 INFO - PROCESS | 7586 | __metrics 07:04:02 ERROR - PROCESS | 7586 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:04:03 INFO - TEST-INFO | 7586: exit 0 07:04:03 INFO - Browser initialized. 07:04:03 INFO - Running cycle 1/1 for kraken test... 07:04:03 INFO - TEST-INFO | started process 7704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjkf_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:15 INFO - PROCESS | 7704 | RSS: Main: 167690240 07:04:15 INFO - PROCESS | 7704 | 07:04:18 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34765/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:19 INFO - PROCESS | 7704 | RSS: Main: 172273664 07:04:19 INFO - PROCESS | 7704 | 07:04:22 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34765/tests/kraken/driver.html?testName=audio-dft) 07:04:22 INFO - PROCESS | 7704 | RSS: Main: 172433408 07:04:22 INFO - PROCESS | 7704 | 07:04:25 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34765/tests/kraken/driver.html?testName=audio-fft) 07:04:26 INFO - PROCESS | 7704 | RSS: Main: 167251968 07:04:26 INFO - PROCESS | 7704 | 07:04:28 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34765/tests/kraken/driver.html?testName=audio-oscillator) 07:04:29 INFO - PROCESS | 7704 | RSS: Main: 168562688 07:04:29 INFO - PROCESS | 7704 | 07:04:31 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:32 INFO - PROCESS | 7704 | RSS: Main: 168460288 07:04:32 INFO - PROCESS | 7704 | 07:04:35 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34765/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:35 INFO - PROCESS | 7704 | RSS: Main: 168665088 07:04:35 INFO - PROCESS | 7704 | 07:04:39 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34765/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:40 INFO - PROCESS | 7704 | RSS: Main: 166785024 07:04:40 INFO - PROCESS | 7704 | 07:04:43 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34765/tests/kraken/driver.html?testName=json-parse-financial) 07:04:43 INFO - PROCESS | 7704 | RSS: Main: 167739392 07:04:43 INFO - PROCESS | 7704 | 07:04:45 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:46 INFO - PROCESS | 7704 | RSS: Main: 168783872 07:04:46 INFO - PROCESS | 7704 | 07:04:48 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:48 INFO - PROCESS | 7704 | RSS: Main: 168439808 07:04:48 INFO - PROCESS | 7704 | 07:04:50 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:51 INFO - PROCESS | 7704 | RSS: Main: 168427520 07:04:51 INFO - PROCESS | 7704 | 07:04:54 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:55 INFO - PROCESS | 7704 | RSS: Main: 168804352 07:04:55 INFO - PROCESS | 7704 | 07:04:58 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:58 INFO - PROCESS | 7704 | RSS: Main: 168562688 07:04:58 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:34765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34765/tests/kraken/driver.html?testName=ai-astar) 07:05:00 INFO - PROCESS | 7704 | RSS: Main: 169308160 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | __start_tp_report 07:05:00 INFO - PROCESS | 7704 | _x_x_mozilla_page_load 07:05:00 INFO - PROCESS | 7704 | _x_x_mozilla_page_load_details 07:05:00 INFO - PROCESS | 7704 | |i|pagename|runs| 07:05:00 INFO - PROCESS | 7704 | |0;ai-astar;114;110;115;117;115;116;113;114;114;116 07:05:00 INFO - PROCESS | 7704 | |1;audio-beat-detection;157;140;153;182;130;157;162;132;179;130 07:05:00 INFO - PROCESS | 7704 | |2;audio-dft;164;163;164;183;163;163;165;161;161;161 07:05:00 INFO - PROCESS | 7704 | |3;audio-fft;78;77;75;153;76;77;75;75;158;77 07:05:00 INFO - PROCESS | 7704 | |4;audio-oscillator;85;84;145;84;84;84;130;85;85;142 07:05:00 INFO - PROCESS | 7704 | |5;imaging-gaussian-blur;122;118;118;118;117;120;118;119;124;122 07:05:00 INFO - PROCESS | 7704 | |6;imaging-darkroom;147;147;148;146;147;148;151;147;148;151 07:05:00 INFO - PROCESS | 7704 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;95;95 07:05:00 INFO - PROCESS | 7704 | |8;json-parse-financial;65;66;67;64;66;64;65;68;64;66 07:05:00 INFO - PROCESS | 7704 | |9;json-stringify-tinderbox;65;66;66;67;67;66;66;65;73;69 07:05:00 INFO - PROCESS | 7704 | |10;stanford-crypto-aes;84;82;90;84;85;85;85;84;120;87 07:05:00 INFO - PROCESS | 7704 | |11;stanford-crypto-ccm;145;134;132;133;143;135;139;134;147;134 07:05:00 INFO - PROCESS | 7704 | |12;stanford-crypto-pbkdf2;172;172;175;171;167;170;181;175;169;174 07:05:00 INFO - PROCESS | 7704 | |13;stanford-crypto-sha256-iterative;68;72;70;68;66;72;68;70;67;68 07:05:00 INFO - PROCESS | 7704 | __end_tp_report 07:05:00 INFO - PROCESS | 7704 | __start_cc_report 07:05:00 INFO - PROCESS | 7704 | _x_x_mozilla_cycle_collect,964 07:05:00 INFO - PROCESS | 7704 | __end_cc_report 07:05:00 INFO - PROCESS | 7704 | __startTimestamp1464703500687__endTimestamp 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | ------- Summary: start ------- 07:05:00 INFO - PROCESS | 7704 | Number of tests: 14 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 07:05:00 INFO - PROCESS | 7704 | Values: 114.0 110.0 115.0 117.0 115.0 116.0 113.0 114.0 114.0 116.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:157.00 stddev:19.12 (12.2%) stddev-sans-first:20.21 07:05:00 INFO - PROCESS | 7704 | Values: 157.0 140.0 153.0 182.0 130.0 157.0 162.0 132.0 179.0 130.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:6.55 (4.0%) stddev-sans-first:6.94 07:05:00 INFO - PROCESS | 7704 | Values: 164.0 163.0 164.0 183.0 163.0 163.0 165.0 161.0 161.0 161.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.50 stddev:33.45 (43.7%) stddev-sans-first:35.09 07:05:00 INFO - PROCESS | 7704 | Values: 78.0 77.0 75.0 153.0 76.0 77.0 75.0 75.0 158.0 77.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.00 stddev:26.63 (31.7%) stddev-sans-first:27.62 07:05:00 INFO - PROCESS | 7704 | Values: 85.0 84.0 145.0 84.0 84.0 84.0 130.0 85.0 85.0 142.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#5] imaging-gaussian-blur Cycles:10 Average:119.60 Median:119.50 stddev:2.32 (1.9%) stddev-sans-first:2.29 07:05:00 INFO - PROCESS | 7704 | Values: 122.0 118.0 118.0 118.0 117.0 120.0 118.0 119.0 124.0 122.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.70 (1.1%) stddev-sans-first:1.76 07:05:00 INFO - PROCESS | 7704 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 151.0 147.0 148.0 151.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:05:00 INFO - PROCESS | 7704 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 07:05:00 INFO - PROCESS | 7704 | Values: 65.0 66.0 67.0 64.0 66.0 64.0 65.0 68.0 64.0 66.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:2.40 (3.6%) stddev-sans-first:2.44 07:05:00 INFO - PROCESS | 7704 | Values: 65.0 66.0 66.0 67.0 67.0 66.0 66.0 65.0 73.0 69.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:11.24 (13.2%) stddev-sans-first:11.79 07:05:00 INFO - PROCESS | 7704 | Values: 84.0 82.0 90.0 84.0 85.0 85.0 85.0 84.0 120.0 87.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:137.00 stddev:5.50 (4.0%) stddev-sans-first:5.14 07:05:00 INFO - PROCESS | 7704 | Values: 145.0 134.0 132.0 133.0 143.0 135.0 139.0 134.0 147.0 134.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:3.92 (2.3%) stddev-sans-first:4.15 07:05:00 INFO - PROCESS | 7704 | Values: 172.0 172.0 175.0 171.0 167.0 170.0 181.0 175.0 169.0 174.0 07:05:00 INFO - PROCESS | 7704 | 07:05:00 INFO - PROCESS | 7704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.02 (2.9%) stddev-sans-first:2.12 07:05:00 INFO - PROCESS | 7704 | Values: 68.0 72.0 70.0 68.0 66.0 72.0 68.0 70.0 67.0 68.0 07:05:00 INFO - PROCESS | 7704 | -------- Summary: end -------- 07:05:00 INFO - PROCESS | 7704 | 07:05:01 INFO - TEST-INFO | 7704: exit 0 07:05:01 INFO - TEST-OK | kraken | took 64709ms 07:05:01 INFO - SUITE-END | took 1180s 07:05:01 INFO - Completed test suite (00:19:40) 07:05:01 INFO - javascript benchmark 07:05:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6267.679361639771, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.1796842978674, 2685.8522781247025, 2685.932851678709, 2699.946001079978, 2725.6729192496905, 4578.15304168729, 4699.85900422987, 4729.361536192618, 4767.6424268179935, 4826.782794774234, 4631.583157515823, 4700.717956922587, 4727.267273572602, 4729.716217026981, 4735.573798358147, 4322.416473776039, 4343.78281085946, 4404.691671582975, 4457.153140903234, 4468.932966005496, 4143.254214241435, 4500.0774841157645, 4512.9097418051615, 4527.049319642879, 4561.384213131235, 4258.616724494779, 4298.226319262531, 4301.075268817188, 4343.066240758237, 4392.934105988413, 4286.335617979218, 4288.957110428887, 4295.205387003414, 4324.264874971231, 4374.431323927901, 4370.38814565961, 4372.519022907478, 4374.212641724488, 4379.4525684289465, 4411.139827733593, 4627.884302892455, 4665.370175026396, 4666.95333046672, 4668.626509879202, 4677.368555245066, 5107.13178759608, 5126.487351264844, 5137.897242055138, 5139.974300128475, 5168.61235407346, 5026.170681837529, 5149.588032957355, 5167.224916262553, 5173.948260517384, 5176.637635365526, 4712.929306060412, 4747.8575642730775, 4753.382060332135, 4759.048190361941, 4806.735629540409, 5187.144121219956, 5190.273361729361, 5193.350831146106, 5194.142966410575, 5198.6880787152895, 4829.9275510867365, 4870.245112007645, 4880.829170978998, 4963.0, 5033.723145227048, 5031.496850314939, 5036.597072234213, 5044.772985215674, 5055.620828437882, 5079.873003174876, 4849.248366503198, 4989.850304490871, 5072.771725272371, 5083.415407228142, 5126.282320475137, 4866.878328041827, 4906.754662266872, 5053.216751403538, 5058.190689489664, 5080.669756465818, 4156.085661154541, 4172.165566886635, 4184.225918205142, 4219.810108545062, 4224.4930608327195, 3666.74332796707, 3672.944905826415, 3693.150575367627, 3699.4820725098507, 3716.089558058293, 4272.230998420252, 4344.348347747863, 4349.717268377545, 4383.912321753547, 4415.51429342772, 5136.512031357015, 5157.484251574812, 5173.456787037382, 5185.248139019821, 5230.450802665665, 4430.579094985971, 4434.800433980478, 4438.400815889813, 4443.230085198379, 4481.663875209372, 4373.190959672471, 4458.71018383804, 4486.304622783474, 4555.703879247838, 4602.171609110325, 4840.467548569584, 4866.853994380174, 4869.366982292279, 4880.243562247857, 4903.53416425439, 5078.619103567321, 5093.337866077386, 5105.795768169231, 5123.052235336475, 5135.2553879687985, 4705.670603057753, 4829.903401932012, 4836.347093142381, 4879.219324907997, 4891.877703057452, 5078.97460512695, 5093.159628661378, 5103.668261562986, 5114.232865070269, 5156.819511317086, 5116.130257856248, 5119.74401279927, 5144.948550514597, 5145.974270128625, 5189.273501709839, 4803.423589169322, 4821.9035619288115, 4937.456879743298, 4972.204447288416, 4977.576905963034, 4889.339939108175, 4903.04390643821, 4912.803487860446, 4934.901301973869, 4971.776270067928, 4857.6599638025, 4863.124637565272, 4885.755712214446, 4906.607471402351, 4949.604031677385, 4836.46798852119, 4933.975330123327, 4963.478834722302, 4986.0, 4996.150654388835, 4848.817483285073, 4900.828471003498, 4911.115999120193, 4915.0415668944215, 4963.0], "value": 4659.67695672614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5398638150764, 599.4305409860633, 603.5051257968465, 620.9937900620995, 626.5175814622738, 34922.30155396891, 39475.407868881986, 39571.60428395715, 39625.801870990676, 39655.80172099135, 40437.59562404375, 41256.793716031454, 41650.54223102192, 41744.58255417452, 41765.37351939723, 7609.8478030439355, 7719.575423351714, 7764.572948487831, 7811.687532498693, 7841.921580784205, 7702.383809295243, 7796.41526885483, 7805.492642978216, 7807.219278072176, 7809.375249980017, 7759.6120193990355, 7782.416318776086, 7784.494007889469, 7808.843823123534, 7835.490693104958, 7633.694652213905, 7790.883136752953, 7794.376449884024, 7798.883016754753, 7827.9608601956625, 7455.105387353552, 7541.0, 7577.621118944031, 7600.733974310928, 7611.885821712679, 29964.0, 37119.25761484782, 37472.063198419986, 37517.624823751685, 37854.43218351727, 3019.6376434827744, 3139.262273365757, 3185.888493902702, 3222.7099561039386, 3709.443583462475, 27342.316442088908, 30718.232044199074, 31511.0, 31589.84205078983, 32189.83905080483, 3133.1697100268448, 3143.072793525915, 3182.3317103408313, 3213.662565430643, 3222.242772948355, 267579.0, 272864.0, 273236.0, 274201.0, 274743.0, 29388.7061129386, 30207.489625519076, 57457.425425745205, 57738.42261577331, 57930.710346447995, 35087.82456087754, 35214.29571408609, 35306.64693353085, 35322.64677353194, 35472.11319716976, 12785.488580456864, 12879.291638959947, 12985.740285194432, 13050.477980880658, 13062.085654004128, 10817.0, 10820.458977051116, 10879.673609791718, 10931.672049838518, 10967.451627418597, 8116.350691944748, 8116.75649730509, 8156.714514991947, 8211.425200235926, 8267.214614611603, 3161.8419079046416, 3235.320582677617, 3238.0609623209007, 3280.721138703237, 3287.9342413151603, 890.643742502991, 927.6224806162843, 1046.2937517176028, 1068.1454836131063, 1080.502968634437, 28422.0, 28425.078132020797, 28535.57196642052, 28910.85544572264, 28919.277018074717, 948.1135138645388, 1023.5905637744961, 1048.250500891866, 1055.3562326980536, 1127.3517727306833, 14898.478553250585, 15250.703690186458, 15286.541403757905, 15459.227038648023, 15463.84536154624, 408412.0, 410898.0, 413269.0, 413499.0, 414896.0, 51289.0, 51557.0, 51875.74062129665, 52071.21893171605, 52137.2179417309, 1189.251450876926, 1211.4064108586906, 1218.3360068762368, 1232.7287996640725, 1243.664210663116, 26864.59703104416, 27827.16518504448, 28241.446720430573, 28246.85876570604, 28398.0, 37798.0, 37997.620023799405, 38119.42820857745, 38291.6170838288, 38314.23371532498, 316780.0, 319318.0, 319858.0, 320437.0, 320523.0, 22945.65581516312, 23491.0, 25901.22296331113, 26226.73773262243, 26294.4741105173, 42878.0, 43747.0, 43922.90192745207, 44277.0, 44416.0, 37165.0, 37342.253154937294, 37348.43977340397, 37603.62396376111, 37790.62209377981, 36694.44958325574, 36768.0, 36788.816055919546, 36803.631963681095, 36947.44578831266, 31929.36141277208, 36096.63903361038, 36317.45523817092, 39376.803115984236, 39768.403473947335, 32723.836380817942, 33525.66474335225, 33885.0, 34230.31539369249, 34341.48487772735, 26032.609510857732, 26076.217713467868, 26103.869480652476, 26346.73653263443, 26552.78963996855], "value": 16682.07027123556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.70782666040503, 360.83762306961864, 368.1036675694682, 378.70082634718574, 384.33510027652176, 15638.765418518717, 16786.66426671466, 17622.0, 17684.292628294854, 17687.911560442197, 15948.28232729527, 16204.675906481863, 16956.0674162921, 17049.659006819857, 17057.317707291724, 5019.749012549367, 5198.714070726109, 5225.634205605609, 5239.056969745444, 5256.763445644955, 3786.8674596389133, 5128.769205385766, 5743.712814359286, 6062.120992456091, 6062.211912451375, 6059.363766804466, 6070.484008859252, 6101.755929762804, 6112.8471788205425, 6134.4478996890275, 5006.173981293082, 5336.493033161843, 5356.839294821161, 5420.783168673248, 5433.6196466247375, 5010.398752149729, 5205.557527610158, 5227.738613069369, 5244.082285600005, 5250.501202385767, 11804.291742495392, 11996.940015299955, 12090.093243006722, 12116.81824772629, 12415.689607759788, 1767.8408943195175, 1928.6721257386278, 1953.8925359105244, 2021.797820217981, 2330.7552706965694, 8916.554172291424, 8962.955185224033, 9030.909690903138, 9544.284178686627, 9547.761305967406, 1654.9420770273102, 1657.5938894970689, 1696.8133505314406, 1700.9829901700948, 1731.5757639378307, 69222.0, 70404.99999999949, 71312.99999999948, 71334.0, 73520.6323968382, 9825.803483930282, 10017.749556261006, 10117.747056323651, 10129.189664826943, 10187.286889917783, 14028.438862445388, 14084.788728169086, 14227.64430889236, 14281.285935703174, 14312.57062288133, 7055.8236044098285, 7150.356467917913, 7164.176119746296, 7188.892166617505, 7231.7107315707835, 6377.298497165308, 6522.706478208492, 6539.247986481616, 6562.80311590653, 6728.125343705287, 4235.767032813224, 4236.385724069993, 4323.135372925364, 4360.127974405132, 4378.693491455568, 1645.4158773635188, 1700.4728534154451, 1748.6327871147203, 1789.2574581548772, 1797.0385843573886, 823.5964377455003, 915.8488849339784, 922.1562270522531, 924.8705181274627, 931.5761328595473, 14226.928865355814, 15548.455804046804, 15944.123073230852, 16373.672526549402, 16544.50366489007, 836.9288610468178, 869.8434281829332, 891.6834523744108, 898.2006014646969, 902.0798785239019, 9000.819983600291, 9291.396059256127, 9413.529323533796, 9431.952840235756, 9442.90557094434, 359927.0, 396602.0, 397618.0, 397967.0, 402460.0, 47417.28874066892, 69308.0, 76198.61900690461, 76681.0, 76985.23014769892, 919.2783664823215, 920.4017388697266, 920.5305294299956, 943.9008904065112, 945.8392073347547, 14405.207713575435, 14597.408020520894, 14721.411143554138, 14739.778903316244, 15162.090274583119, 33460.83269583636, 34881.825590871886, 36809.44785828161, 37767.24465510729, 38075.428868566436, 45619.54380456153, 49887.0, 49964.50035499599, 50233.74883125561, 50284.49715502798, 7022.894656580258, 7126.109236345457, 7175.748848790267, 7211.3870321023305, 7232.240614735588, 7032.718691252293, 7937.325327347009, 9640.614375425184, 10180.847287290844, 10555.683329500127, 4695.6243500519195, 4850.53919877611, 9070.863937041082, 9237.89145302568, 9715.805683886425, 9298.302627302844, 9317.0, 9377.484238366682, 9690.612375504901, 9794.951025245113, 9472.194863436409, 9817.263705221994, 9960.306747852737, 9980.051895069957, 10028.147607453448, 6931.480138989495, 6986.650667466504, 7088.0785497884945, 7095.822604434724, 7096.8935465967015, 9006.234470069856, 9359.906400936175, 9422.764430889009, 9642.855357169788, 9843.507824608883], "value": 7836.659209097128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.4986254810817, 1462.5319897632758, 1591.6657501924594, 1750.7373893915903, 1779.5906941403478, 6882.380585747282, 7518.0, 7549.584772837492, 8146.91853081469, 8147.755567332974, 7582.962085189566, 7714.112877019144, 7742.883856742139, 7765.844683106335, 7802.453828232026, 2119.1205649655412, 2157.892105394732, 2158.935231943044, 2160.643493823525, 2165.65349544073, 2027.523531969986, 2053.9216911121707, 2121.469632591852, 2127.308624696972, 2129.6166689995794, 2101.05452546354, 2104.463361842728, 2122.766495685481, 2127.425595089325, 2163.826893848496, 2092.2990798082583, 2098.244631932503, 2101.8423618228617, 2104.2635077722825, 2115.3548167808813, 2070.8653937494164, 2119.6608542633257, 2135.1672847589452, 2151.9784802151935, 2164.4805246740825, 7503.474756767028, 7560.659770310349, 7566.394688424913, 7586.886196707053, 7656.923430765677, 4532.456105267389, 4555.293929440909, 4597.149527337453, 4602.838900638495, 4603.378543896564, 2742.7120152383914, 2871.267826704198, 2948.882044718209, 2959.4672958867395, 2959.7632189424794, 834.0491839303139, 863.5466380150408, 881.3037700216821, 888.6889588643922, 900.333753022765, 10944.3980581068, 10983.340999540053, 11045.613403530839, 11054.889451105466, 11064.391458469781, 4201.537830838605, 4252.702310838212, 4327.56724327571, 4341.153475072394, 4344.978275108604, 9298.209652179505, 9321.72034838956, 9348.57931393089, 9389.248860091177, 9400.670976515788, 4535.682502224812, 4563.133004729158, 4576.359309696645, 4600.378948841931, 4632.2125238709505, 3669.302832461877, 4072.857449989236, 4189.727667701651, 4203.684723645739, 4231.61915427613, 3696.334659761215, 3698.7965661888857, 3789.8105094745706, 3791.1280405506886, 3820.2741479119436, 1159.7448561316496, 1191.338083373689, 1214.7023979124995, 1215.465195314059, 1217.817327400897, 796.4783067091065, 833.5623797506237, 898.1467605774541, 905.6467977488785, 912.333996182777, 5385.6230063895155, 5468.863278418072, 5534.889302214014, 5582.888342233133, 5667.348254950651, 815.6615004773072, 835.7367429259764, 871.3203701113142, 893.5487578772678, 908.2280061947292, 3927.3127202739406, 3931.803409829497, 4002.639762421396, 4009.498812648419, 4023.1752490739914, 9237.90762092384, 9562.426254424758, 9660.130588247092, 9894.802103958025, 9917.15704165154, 9742.366746161477, 9824.11582957523, 9829.508524573743, 9834.0, 9860.852087218698, 7318.377937875341, 7484.101907771103, 7484.999999999891, 7488.326050655467, 7506.699732010768, 5538.307711536058, 5693.3168019837885, 5709.058005429224, 5774.307083150049, 5808.970955145197, 8776.868346974928, 9057.456552606865, 9106.225970792557, 9220.585073671567, 9303.860442093239, 8646.351523635627, 9038.960519540336, 9053.411528250906, 9368.906310936803, 9392.342536022414, 5872.853178670567, 6617.371349721769, 6765.797026089225, 6843.076184715199, 6918.0314755935215, 7461.701531938662, 7496.812579685551, 7527.0, 7536.057992750906, 7547.433942454448, 6480.773172938924, 6658.43403310724, 6704.396604305441, 6776.6950487227205, 6837.863242735018, 6404.487640988803, 6492.220933488012, 6544.934550654432, 6598.175228096488, 6667.966660166862, 6409.935900640934, 6453.225612926479, 6477.4494167996245, 6481.578697384655, 6488.416042556192, 4675.205215113507, 4684.110019096361, 4783.904321913473, 4785.617150628011, 4823.324734537237, 4759.881002974953, 4851.32081508582, 4969.950300496948, 4970.105381031304, 4974.32846565709], "value": 4184.63429680169, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6579964639958, 302.6595080534399, 304.5644728038904, 309.4321919278124, 310.2383648143806, 5043.722595257269, 5072.695638261707, 5100.030994111125, 5107.668001579895, 5145.073886700397, 4974.8608098517625, 4979.203327467606, 4979.979104283622, 4982.377202849644, 4991.875203119924, 3744.438334249871, 3805.7145714071557, 3936.2127574485075, 3941.4284928685324, 3952.486176797027, 3944.605539446047, 3980.104476492795, 3985.501812273466, 3992.740471869319, 3997.4403583498333, 3924.646781789638, 3946.6842652587866, 3951.841926322958, 3956.8417263309434, 3965.762054276738, 3759.3797023491366, 3915.804209789499, 3920.372740361557, 3938.1926705025403, 3940.0937784309626, 3473.8436770345143, 3480.112571294329, 3483.74585149346, 3489.354469423165, 3489.8778542751134, 4833.709977401332, 4862.5380588844, 4864.8297309594345, 4866.707997520125, 4903.26451032348, 4436.933445998313, 4537.799167403807, 4550.340200670884, 4575.633949284049, 4612.584867361954, 5241.292425522543, 5255.6583822051825, 5258.421573626898, 5273.261743355895, 5290.39160496544, 3784.6404591563755, 3807.714421418377, 3815.8473661053526, 3821.522309711286, 3826.1199924017355, 5426.782928682848, 5535.035062552816, 5543.362513310981, 5560.36055853578, 5569.526590239794, 3867.9613203867602, 3876.6898648108086, 3897.922041559153, 3926.312895243321, 3928.273269445162, 3925.4111883217747, 3961.6632586229916, 3968.2857085724845, 3970.900727481836, 3974.423708562242, 4467.553244675506, 4480.327950807405, 4490.618297444754, 4500.514830106123, 4507.6168525675685, 5039.79840806371, 5117.8464646060675, 5138.691678499302, 5209.426963034063, 5271.65734227274, 1346.6566025663394, 1358.151155527795, 1361.8501964783866, 1377.9862201378057, 1381.240317825192, 847.186700767258, 864.7276108025952, 874.4141425245101, 881.722257488889, 885.8538341173763, 4456.732596044248, 4506.107434877359, 4507.932381014288, 4555.954440455619, 4559.407277054028, 5374.220737992969, 5376.193570964387, 5379.246905433242, 5392.676439413648, 5393.919091213635, 4374.763054452533, 4534.659900507475, 4540.931886021713, 4542.432195975503, 4553.362529245908, 2852.657681078284, 2877.863244018601, 2886.6536015678253, 2893.59660564626, 2902.242869274198, 5084.932164245476, 5097.108006098918, 5107.182850743938, 5124.282600435942, 5128.666636668605, 5250.107481728115, 5532.5297349724915, 5548.86127846799, 5550.8057217997175, 5553.888922221533, 5141.331626888556, 5150.27896094547, 5152.278680984665, 5166.560842328369, 5192.844214673566, 5417.83746487606, 5456.399796022513, 5462.562994960473, 5470.699111548903, 5483.396826349178, 5193.221016847503, 5273.709945953009, 5295.152775555893, 5313.654612450178, 5324.775301680557, 5125.79496820123, 5131.717755523333, 5139.665921715076, 5168.733660253262, 5173.0, 3729.9254014919006, 3734.925301494009, 3772.4718539405053, 3789.905252368713, 3798.6581207691443, 5266.605004624592, 5447.564194864322, 5462.098753705753, 5479.232907392889, 5553.6390134641115, 5262.8947421052135, 5296.2320463531805, 5297.761600727899, 5306.469353064663, 5313.246628612471, 5217.113090774654, 5244.370675518962, 5248.396434410091, 5268.472143078464, 5295.934585511576, 4938.678985866051, 5182.429932707475, 5189.754458929905, 5194.558462530727, 5211.426743058337, 5048.258350868944, 5148.536631703165, 5286.3568215892055, 5301.125314323248, 5327.946720532745, 5175.275461435327, 5186.792528298825, 5196.246544251138, 5200.5059519345605, 5210.843674689765], "value": 3970.4884693205704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.5932762359713, 656.9375909288616, 658.279184293199, 684.712420783271, 698.53547390985, 10600.469976501183, 11913.285202887822, 12195.451204695788, 12227.14409991301, 12297.077719171064, 11566.07471402288, 11625.418729063555, 11645.18483706141, 11668.35824029678, 11916.0, 628.3025841316136, 786.1509569664748, 790.6205021589641, 792.8572856885759, 811.3955103447939, 800.047942947893, 802.2258520527689, 802.7993001749562, 803.5459965119718, 804.2440106300088, 837.8156805502811, 840.5461051032435, 841.0538144587339, 841.5960339037266, 841.7390608911227, 828.5028982610446, 830.9210624990616, 834.2866848844242, 834.9415540912139, 835.2816577743137, 612.1093808508609, 612.6507890502415, 616.0758861707438, 616.2420223125536, 616.552999075671, 11981.041516678732, 12019.879801201963, 12021.759564808743, 12022.27866328023, 12073.215241009306, 12449.257104005446, 12585.811212831815, 12592.307423091726, 12780.569016261847, 12926.159799612995, 9966.900330996743, 10042.397456152654, 10065.24510661696, 10269.794604107876, 10466.162706983423, 3239.9352012959607, 3258.0877354340587, 3273.885414010498, 3296.703296703284, 3338.565986421774, 40235.0, 42271.36592951077, 42297.788511057865, 45978.54021459776, 46222.0, 10020.549075291628, 10112.342697724771, 10176.0, 10205.285630005978, 10373.481325933673, 16745.0, 16787.160641967854, 16851.325946962228, 16886.0, 16891.15544222784, 6339.334369891095, 6492.443450657836, 6816.079829222991, 6902.206246281641, 6959.547629404073, 3733.4026555751493, 3798.924021519554, 3853.845846166122, 3906.160175562211, 3975.1652153047607, 2825.660920689489, 2976.300569366197, 3001.5197568388953, 3007.3083190866223, 3013.6383633964065, 607.902735562308, 608.7473698415197, 610.6366711806468, 610.7984365159487, 610.8045425463808, 486.65204378869277, 561.5984571031732, 584.3893131677407, 585.3268740947944, 631.62418361076, 8308.5430301334, 8376.162383761697, 8568.614412351459, 8704.95647521771, 8712.782180445412, 556.834875134, 558.9469000444951, 614.4040280927493, 620.3920158244945, 625.6777759453885, 3985.80070996449, 4018.216447792711, 4061.5126184858004, 4104.0, 4105.753654780663, 57991.420085799444, 58510.0, 59498.40501594928, 59875.401245986985, 59989.0, 53835.73082134564, 54111.0, 54875.0, 54877.72561137249, 56199.71900140473, 50190.498095018585, 50961.490385095676, 51353.99999999925, 51365.486345136815, 51449.48550514522, 7168.2831716827895, 7215.567065976058, 7285.817854553678, 7313.341799237881, 7513.511621744569, 33006.33987320192, 33591.832040840614, 33708.15729606681, 34178.82910585431, 34668.0, 40031.1993760129, 42389.36415953825, 44286.0, 44527.0, 44947.550524494334, 9503.619855205714, 9689.563969621244, 9853.16248118918, 9863.753406164904, 9909.306348555532, 10640.574377024832, 10735.516901739597, 10895.836562451412, 11181.776364472827, 11330.546778128783, 9754.561044753145, 10346.689599312032, 10471.3193642413, 10534.26260161812, 10638.361698298128, 10222.437765922945, 10265.281430300107, 10284.177265818567, 10356.342436146202, 10456.251963164785, 9880.50597470138, 10196.796064078528, 10860.402677852793, 10951.123910087334, 11037.39294338787, 9178.770530736785, 9344.906550934676, 9381.921079075993, 9433.198178154933, 9720.562574684014, 9124.817503650023, 9405.341626086109, 9483.525823708926, 9548.474833884204, 9585.329026968046], "value": 5989.049283127218, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 117.0, 115.0, 116.0, 113.0, 114.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 140.0, 153.0, 182.0, 130.0, 157.0, 162.0, 132.0, 179.0, 130.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 183.0, 163.0, 163.0, 165.0, 161.0, 161.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 75.0, 153.0, 76.0, 77.0, 75.0, 75.0, 158.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 145.0, 84.0, 84.0, 84.0, 130.0, 85.0, 85.0, 142.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0, 119.0, 124.0, 122.0], "value": 119.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 151.0, 147.0, 148.0, 151.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 64.0, 66.0, 64.0, 65.0, 68.0, 64.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 73.0, 69.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 90.0, 84.0, 85.0, 85.0, 85.0, 84.0, 120.0, 87.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 132.0, 133.0, 143.0, 135.0, 139.0, 134.0, 147.0, 134.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 175.0, 171.0, 167.0, 170.0, 181.0, 175.0, 169.0, 174.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 70.0, 68.0, 66.0, 72.0, 68.0, 70.0, 67.0, 68.0], "value": 68.9, "unit": "score"}]}]} 07:05:01 INFO - Return code: 0 07:05:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:05:01 ERROR - # TBPL SUCCESS # 07:05:01 INFO - Running post-action listener: _resource_record_post_action 07:05:01 INFO - ##### 07:05:01 INFO - ##### Finished run-tests step (success) 07:05:01 INFO - ##### 07:05:01 INFO - Running post-run listener: _resource_record_post_run 07:05:02 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 73728; Write bytes: 315830272; Read time: 32; Write time: 252776 07:05:02 INFO - TinderboxPrint: CPU usage
13.4% 07:05:02 INFO - TinderboxPrint: I/O read bytes / time
73,728 / 32 07:05:02 INFO - TinderboxPrint: I/O write bytes / time
315,830,272 / 252,776 07:05:02 INFO - TinderboxPrint: CPU idle
8,277.6 (86.6%) 07:05:02 INFO - TinderboxPrint: CPU user
1,228.1 (12.8%) 07:05:02 INFO - TinderboxPrint: Swap in / out
0 / 0 07:05:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18804736; Read time: 0; Write time: 6056 07:05:02 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 73728; Write bytes: 297025536; Read time: 32; Write time: 246720 07:05:02 INFO - Running post-run listener: _upload_blobber_files 07:05:02 INFO - Blob upload gear active. 07:05:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:05:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:05:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:03 INFO - (blobuploader) - INFO - Done attempting. 07:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:04 INFO - (blobuploader) - INFO - Done attempting. 07:05:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:05:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:08 INFO - (blobuploader) - INFO - Done attempting. 07:05:08 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:08 INFO - Return code: 0 07:05:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc6ed847314d560b69d3dadaaa067821755e0426a2bfef4ad50d4c95191dce4a7fda4e4ed26b523767666dc654466a0ce3e80e6267bca8b4923e87af4294df4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ea59d8a3b8bfc4f417b27676a5f447cf292056ecbe1da89a8d1eacf6f53d61c3cf72573fceac3254648975463175bc2100d2a026843928ae3ce3b57afe232e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0926e8e2f168e737898de72ce2355deb1fda5732d34919f36b383ee64480819c35b6a749d5a4aeae5474743eea3e5601be8a96f6c22c1f08998b26143e32feba"} 07:05:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:08 INFO - Contents: 07:05:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc6ed847314d560b69d3dadaaa067821755e0426a2bfef4ad50d4c95191dce4a7fda4e4ed26b523767666dc654466a0ce3e80e6267bca8b4923e87af4294df4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ea59d8a3b8bfc4f417b27676a5f447cf292056ecbe1da89a8d1eacf6f53d61c3cf72573fceac3254648975463175bc2100d2a026843928ae3ce3b57afe232e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0926e8e2f168e737898de72ce2355deb1fda5732d34919f36b383ee64480819c35b6a749d5a4aeae5474743eea3e5601be8a96f6c22c1f08998b26143e32feba"} 07:05:08 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:08 INFO - Copying logs to upload dir... 07:05:08 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.214687 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-31 07:05:08.338081) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:08.343983) ========= 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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 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/Fx-Team-Non-PGO/sha512/cc6ed847314d560b69d3dadaaa067821755e0426a2bfef4ad50d4c95191dce4a7fda4e4ed26b523767666dc654466a0ce3e80e6267bca8b4923e87af4294df4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ea59d8a3b8bfc4f417b27676a5f447cf292056ecbe1da89a8d1eacf6f53d61c3cf72573fceac3254648975463175bc2100d2a026843928ae3ce3b57afe232e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0926e8e2f168e737898de72ce2355deb1fda5732d34919f36b383ee64480819c35b6a749d5a4aeae5474743eea3e5601be8a96f6c22c1f08998b26143e32feba"} build_url:https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/LKzjYDKyRae9NdJZqYB0yQ/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/Fx-Team-Non-PGO/sha512/cc6ed847314d560b69d3dadaaa067821755e0426a2bfef4ad50d4c95191dce4a7fda4e4ed26b523767666dc654466a0ce3e80e6267bca8b4923e87af4294df4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ea59d8a3b8bfc4f417b27676a5f447cf292056ecbe1da89a8d1eacf6f53d61c3cf72573fceac3254648975463175bc2100d2a026843928ae3ce3b57afe232e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0926e8e2f168e737898de72ce2355deb1fda5732d34919f36b383ee64480819c35b6a749d5a4aeae5474743eea3e5601be8a96f6c22c1f08998b26143e32feba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:08.370558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:08.370902) ========= 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=7de08804244eb36560b44971000001c3-1464701328.856026-920692429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:05:08.453789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 07:05:08.454121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 07:05:08.454473) ========= ========= Total master_lag: 0.20 =========