builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1463373993.94 results: success (0) buildid: 20160515203829 builduid: fd462b370e5544bdae0208c7f82b5fc7 revision: d0be57e84807ce0853b2406de7ff6abb195ac898 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:33.941647) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:33.942184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:33.942655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:33.966564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:33.966846) ========= 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=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-15 21:46:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-15 21:46:34 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.109108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.109884) ========= 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=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020029 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.162342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.163210) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0be57e84807ce0853b2406de7ff6abb195ac898 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d0be57e84807ce0853b2406de7ff6abb195ac898 --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=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-15 21:46:34,325 truncating revision to first 12 chars 2016-05-15 21:46:34,325 Setting DEBUG logging. 2016-05-15 21:46:34,325 attempt 1/10 2016-05-15 21:46:34,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0be57e84807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-15 21:46:34,595 unpacking tar archive at: mozilla-central-d0be57e84807/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.727991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.728713) ========= script_repo_revision: d0be57e84807ce0853b2406de7ff6abb195ac898 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.729777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.730528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 21:46:34.744631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-15 21:46:34.744990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:46:34 INFO - MultiFileLogger online at 20160515 21:46:34 in /builds/slave/test 21:46:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:46:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:34 INFO - {'append_to_log': False, 21:46:34 INFO - 'base_work_dir': '/builds/slave/test', 21:46:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:46:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:34 INFO - 'branch': 'Firefox-Non-PGO', 21:46:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:34 INFO - 'config_files': ('talos/linux_config.py',), 21:46:34 INFO - 'default_actions': ('clobber', 21:46:34 INFO - 'read-buildbot-config', 21:46:34 INFO - 'download-and-extract', 21:46:34 INFO - 'populate-webroot', 21:46:34 INFO - 'create-virtualenv', 21:46:34 INFO - 'install', 21:46:34 INFO - 'run-tests'), 21:46:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:34 INFO - 'download_minidump_stackwalk': True, 21:46:34 INFO - 'download_symbols': 'ondemand', 21:46:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:34 INFO - 'installer_path': 'installer.exe', 21:46:34 INFO - 'log_level': 'info', 21:46:34 INFO - 'log_name': 'talos', 21:46:34 INFO - 'log_to_console': True, 21:46:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:46:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:46:34 INFO - 'opt_config_files': (), 21:46:34 INFO - 'pip_index': False, 21:46:34 INFO - 'sps_profile': False, 21:46:34 INFO - 'sps_profile_interval': 0, 21:46:34 INFO - 'suite': 'dromaeojs-e10s', 21:46:34 INFO - 'system_bits': '32', 21:46:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:34 INFO - 'title': 'talos-linux64-ix-016', 21:46:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:34 INFO - 'use_talos_json': True, 21:46:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:34 INFO - 'work_dir': 'build'} 21:46:34 INFO - ##### 21:46:34 INFO - ##### Running clobber step. 21:46:34 INFO - ##### 21:46:34 INFO - Running pre-action listener: _resource_record_pre_action 21:46:34 INFO - Running main action method: clobber 21:46:34 INFO - rmtree: /builds/slave/test/build 21:46:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:35 INFO - Running post-action listener: _resource_record_post_action 21:46:35 INFO - ##### 21:46:35 INFO - ##### Finished clobber step (success) 21:46:35 INFO - ##### 21:46:35 INFO - ##### 21:46:35 INFO - ##### Running read-buildbot-config step. 21:46:35 INFO - ##### 21:46:35 INFO - Running pre-action listener: _resource_record_pre_action 21:46:35 INFO - Running main action method: read_buildbot_config 21:46:35 INFO - Using buildbot properties: 21:46:35 INFO - { 21:46:35 INFO - "project": "", 21:46:35 INFO - "product": "firefox", 21:46:35 INFO - "script_repo_revision": "production", 21:46:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:46:35 INFO - "repository": "", 21:46:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:46:35 INFO - "buildid": "20160515203829", 21:46:35 INFO - "pgo_build": "False", 21:46:35 INFO - "basedir": "/builds/slave/test", 21:46:35 INFO - "buildnumber": 56, 21:46:35 INFO - "slavename": "talos-linux64-ix-016", 21:46:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:46:35 INFO - "platform": "ubuntu64_hw", 21:46:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:46:35 INFO - "branch": "mozilla-central", 21:46:35 INFO - "repo_path": "mozilla-central", 21:46:35 INFO - "revision": "d0be57e84807ce0853b2406de7ff6abb195ac898", 21:46:35 INFO - "stage_platform": "linux64", 21:46:35 INFO - "builduid": "fd462b370e5544bdae0208c7f82b5fc7", 21:46:35 INFO - "slavebuilddir": "test" 21:46:35 INFO - } 21:46:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:46:35 INFO - Running post-action listener: _resource_record_post_action 21:46:35 INFO - ##### 21:46:35 INFO - ##### Finished read-buildbot-config step (success) 21:46:35 INFO - ##### 21:46:35 INFO - ##### 21:46:35 INFO - ##### Running download-and-extract step. 21:46:35 INFO - ##### 21:46:35 INFO - Running pre-action listener: _resource_record_pre_action 21:46:35 INFO - Running main action method: download_and_extract 21:46:35 INFO - mkdir: /builds/slave/test/build/tests 21:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:35 INFO - https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:36 INFO - Downloaded 1361 bytes. 21:46:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:46:36 INFO - Using the following test package requirements: 21:46:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:46:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:46:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'jsshell-linux-x86_64.zip'], 21:46:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:46:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:46:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:46:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:46:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:46:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:36 INFO - https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:37 INFO - Downloaded 22447955 bytes. 21:46:37 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'] 21:46:37 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 21:46:38 INFO - Return code: 0 21:46:38 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 21:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:38 INFO - https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:41 INFO - Downloaded 22447955 bytes. 21:46:41 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'] 21:46:41 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 21:46:42 INFO - Return code: 0 21:46:42 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')]} 21:46:42 INFO - https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:43 INFO - Downloaded 10840194 bytes. 21:46:43 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'] 21:46:43 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 21:46:43 INFO - Return code: 0 21:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:43 INFO - https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCs880ZaSqitwvq6IEVjaQ/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 21:46:44 INFO - Downloaded 54746950 bytes. 21:46:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:46:44 INFO - mkdir: /builds/slave/test/properties 21:46:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:44 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:44 INFO - Contents: 21:46:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:46:45 INFO - Running post-action listener: _resource_record_post_action 21:46:45 INFO - Running post-action listener: set_extra_try_arguments 21:46:45 INFO - ##### 21:46:45 INFO - ##### Finished download-and-extract step (success) 21:46:45 INFO - ##### 21:46:45 INFO - ##### 21:46:45 INFO - ##### Running populate-webroot step. 21:46:45 INFO - ##### 21:46:45 INFO - Running pre-action listener: _resource_record_pre_action 21:46:45 INFO - Running main action method: populate_webroot 21:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:45 INFO - '--tppagecycles', 21:46:45 INFO - '7'], 21:46:45 INFO - 'tests': ['tsvgm']}}, 21:46:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['damp', 'tps']}, 21:46:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'tests': ['damp', 'tps']}, 21:46:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['dromaeo_dom']}, 21:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['a11yr', 21:46:45 INFO - 'ts_paint', 21:46:45 INFO - 'tpaint', 21:46:45 INFO - 'sessionrestore', 21:46:45 INFO - 'sessionrestore_no_auto_restore', 21:46:45 INFO - 'tabpaint']}, 21:46:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['tsvgx', 21:46:45 INFO - 'tsvgr_opacity', 21:46:45 INFO - 'tart', 21:46:45 INFO - 'tscrollx', 21:46:45 INFO - 'cart']}, 21:46:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:45 INFO - 'tsvgr_opacity', 21:46:45 INFO - 'tart', 21:46:45 INFO - 'tscrollx', 21:46:45 INFO - 'cart']}, 21:46:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'talos_options': ['--disable-e10s'], 21:46:45 INFO - 'tests': ['tp5o']}, 21:46:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'tests': ['tp5o']}, 21:46:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'talos_options': ['--disable-e10s', 21:46:45 INFO - '--xperf_path', 21:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:45 INFO - 'tests': ['tp5n']}, 21:46:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:45 INFO - 'talos_options': ['--xperf_path', 21:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:45 INFO - 'tests': ['tp5n']}}, 21:46:45 INFO - 'talos.zip': {'path': '', 21:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:45 INFO - Running post-action listener: _resource_record_post_action 21:46:45 INFO - ##### 21:46:45 INFO - ##### Finished populate-webroot step (success) 21:46:45 INFO - ##### 21:46:45 INFO - ##### 21:46:45 INFO - ##### Running create-virtualenv step. 21:46:45 INFO - ##### 21:46:45 INFO - Running pre-action listener: _resource_record_pre_action 21:46:45 INFO - Running main action method: create_virtualenv 21:46:45 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:45 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 21:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:45 INFO - Using real prefix '/usr' 21:46:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:48 INFO - Installing pip.................done. 21:46:48 INFO - Return code: 0 21:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:46:48 INFO - Using env: {'DISPLAY': ':0', 21:46:48 INFO - 'HOME': '/home/cltbld', 21:46:48 INFO - 'LANG': 'en_US.UTF-8', 21:46:48 INFO - 'LANGUAGE': 'en_US:en', 21:46:48 INFO - 'LOGNAME': 'cltbld', 21:46:48 INFO - 'MAIL': '/var/mail/cltbld', 21:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:48 INFO - 'MOZ_NO_REMOTE': '1', 21:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:48 INFO - 'NO_EM_RESTART': '1', 21:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:48 INFO - 'PWD': '/builds/slave/test', 21:46:48 INFO - 'SHELL': '/bin/bash', 21:46:48 INFO - 'SHLVL': '1', 21:46:48 INFO - 'TERM': 'linux', 21:46:48 INFO - 'TMOUT': '86400', 21:46:48 INFO - 'USER': 'cltbld', 21:46:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:48 INFO - '_': '/tools/buildbot/bin/python'} 21:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:48 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 21:46:48 INFO - Cleaning up... 21:46:48 INFO - Return code: 0 21:46:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:46:48 INFO - Using env: {'DISPLAY': ':0', 21:46:48 INFO - 'HOME': '/home/cltbld', 21:46:48 INFO - 'LANG': 'en_US.UTF-8', 21:46:48 INFO - 'LANGUAGE': 'en_US:en', 21:46:48 INFO - 'LOGNAME': 'cltbld', 21:46:48 INFO - 'MAIL': '/var/mail/cltbld', 21:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:48 INFO - 'MOZ_NO_REMOTE': '1', 21:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:48 INFO - 'NO_EM_RESTART': '1', 21:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:48 INFO - 'PWD': '/builds/slave/test', 21:46:48 INFO - 'SHELL': '/bin/bash', 21:46:48 INFO - 'SHLVL': '1', 21:46:48 INFO - 'TERM': 'linux', 21:46:48 INFO - 'TMOUT': '86400', 21:46:48 INFO - 'USER': 'cltbld', 21:46:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:48 INFO - '_': '/tools/buildbot/bin/python'} 21:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:48 INFO - Downloading/unpacking psutil>=3.1.1 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:50 INFO - Installing collected packages: psutil 21:46:50 INFO - Running setup.py install for psutil 21:46:50 INFO - building 'psutil._psutil_linux' extension 21:46:50 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 21:46:51 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 21:46:51 INFO - building 'psutil._psutil_posix' extension 21:46:51 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 21:46:51 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 21:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:51 INFO - Successfully installed psutil 21:46:51 INFO - Cleaning up... 21:46:51 INFO - Return code: 0 21:46:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46:51 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')]} 21:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:51 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')]} 21:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:51 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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:46:51 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 21:46:51 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 21:46:51 INFO - Using env: {'DISPLAY': ':0', 21:46:51 INFO - 'HOME': '/home/cltbld', 21:46:51 INFO - 'LANG': 'en_US.UTF-8', 21:46:51 INFO - 'LANGUAGE': 'en_US:en', 21:46:51 INFO - 'LOGNAME': 'cltbld', 21:46:51 INFO - 'MAIL': '/var/mail/cltbld', 21:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:51 INFO - 'MOZ_NO_REMOTE': '1', 21:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:51 INFO - 'NO_EM_RESTART': '1', 21:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:51 INFO - 'PWD': '/builds/slave/test', 21:46:51 INFO - 'SHELL': '/bin/bash', 21:46:51 INFO - 'SHLVL': '1', 21:46:51 INFO - 'TERM': 'linux', 21:46:51 INFO - 'TMOUT': '86400', 21:46:51 INFO - 'USER': 'cltbld', 21:46:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:51 INFO - '_': '/tools/buildbot/bin/python'} 21:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:53 INFO - Installing collected packages: mozsystemmonitor 21:46:53 INFO - Running setup.py install for mozsystemmonitor 21:46:53 INFO - Successfully installed mozsystemmonitor 21:46:53 INFO - Cleaning up... 21:46:53 INFO - Return code: 0 21:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:46:53 INFO - Using env: {'DISPLAY': ':0', 21:46:53 INFO - 'HOME': '/home/cltbld', 21:46:53 INFO - 'LANG': 'en_US.UTF-8', 21:46:53 INFO - 'LANGUAGE': 'en_US:en', 21:46:53 INFO - 'LOGNAME': 'cltbld', 21:46:53 INFO - 'MAIL': '/var/mail/cltbld', 21:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:53 INFO - 'MOZ_NO_REMOTE': '1', 21:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:53 INFO - 'NO_EM_RESTART': '1', 21:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:53 INFO - 'PWD': '/builds/slave/test', 21:46:53 INFO - 'SHELL': '/bin/bash', 21:46:53 INFO - 'SHLVL': '1', 21:46:53 INFO - 'TERM': 'linux', 21:46:53 INFO - 'TMOUT': '86400', 21:46:53 INFO - 'USER': 'cltbld', 21:46:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:53 INFO - '_': '/tools/buildbot/bin/python'} 21:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - Downloading docopt-0.6.1.tar.gz 21:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:56 INFO - Running setup.py install for blobuploader 21:46:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:56 INFO - Running setup.py install for requests 21:46:57 INFO - Running setup.py install for docopt 21:46:57 INFO - Successfully installed blobuploader requests docopt 21:46:57 INFO - Cleaning up... 21:46:57 INFO - Return code: 0 21:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:57 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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:46:57 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 21:46:57 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 21:46:57 INFO - Using env: {'DISPLAY': ':0', 21:46:57 INFO - 'HOME': '/home/cltbld', 21:46:57 INFO - 'LANG': 'en_US.UTF-8', 21:46:57 INFO - 'LANGUAGE': 'en_US:en', 21:46:57 INFO - 'LOGNAME': 'cltbld', 21:46:57 INFO - 'MAIL': '/var/mail/cltbld', 21:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:57 INFO - 'MOZ_NO_REMOTE': '1', 21:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:57 INFO - 'NO_EM_RESTART': '1', 21:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:57 INFO - 'PWD': '/builds/slave/test', 21:46:57 INFO - 'SHELL': '/bin/bash', 21:46:57 INFO - 'SHLVL': '1', 21:46:57 INFO - 'TERM': 'linux', 21:46:57 INFO - 'TMOUT': '86400', 21:46:57 INFO - 'USER': 'cltbld', 21:46:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:57 INFO - '_': '/tools/buildbot/bin/python'} 21:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:57 INFO - Running setup.py (path:/tmp/pip-C7A50K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:57 INFO - Running setup.py (path:/tmp/pip-tjY4xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:57 INFO - Running setup.py (path:/tmp/pip-du3wwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:57 INFO - Running setup.py (path:/tmp/pip-IzGy6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:57 INFO - Running setup.py (path:/tmp/pip-lITTrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:57 INFO - Running setup.py (path:/tmp/pip-AvfTgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:57 INFO - Running setup.py (path:/tmp/pip-xpc6UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:57 INFO - Running setup.py (path:/tmp/pip-xt0sO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:57 INFO - Running setup.py (path:/tmp/pip-76EN7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:58 INFO - Running setup.py (path:/tmp/pip-Jz2WIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:58 INFO - Running setup.py (path:/tmp/pip-Kp_RF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:58 INFO - Running setup.py (path:/tmp/pip-WCrPVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:58 INFO - Running setup.py (path:/tmp/pip-LQxuDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:58 INFO - Running setup.py (path:/tmp/pip-beWuxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:58 INFO - Running setup.py (path:/tmp/pip-Qj9A2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:58 INFO - Running setup.py (path:/tmp/pip-iCuX8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:58 INFO - Running setup.py (path:/tmp/pip-8ZBXVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:58 INFO - Running setup.py install for manifestparser 21:46:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:58 INFO - Running setup.py install for mozcrash 21:46:58 INFO - Running setup.py install for mozdebug 21:46:58 INFO - Running setup.py install for mozdevice 21:46:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozfile 21:46:59 INFO - Running setup.py install for mozhttpd 21:46:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozinfo 21:46:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozInstall 21:46:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozleak 21:46:59 INFO - Running setup.py install for mozlog 21:46:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for moznetwork 21:46:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozprocess 21:46:59 INFO - Running setup.py install for mozprofile 21:46:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Running setup.py install for mozrunner 21:47:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:00 INFO - Running setup.py install for mozscreenshot 21:47:00 INFO - Running setup.py install for moztest 21:47:00 INFO - Running setup.py install for mozversion 21:47:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:00 INFO - Cleaning up... 21:47:00 INFO - Return code: 0 21:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:00 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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:47:00 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 21:47:00 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 21:47:00 INFO - Using env: {'DISPLAY': ':0', 21:47:00 INFO - 'HOME': '/home/cltbld', 21:47:00 INFO - 'LANG': 'en_US.UTF-8', 21:47:00 INFO - 'LANGUAGE': 'en_US:en', 21:47:00 INFO - 'LOGNAME': 'cltbld', 21:47:00 INFO - 'MAIL': '/var/mail/cltbld', 21:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:00 INFO - 'MOZ_NO_REMOTE': '1', 21:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:00 INFO - 'NO_EM_RESTART': '1', 21:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:00 INFO - 'PWD': '/builds/slave/test', 21:47:00 INFO - 'SHELL': '/bin/bash', 21:47:00 INFO - 'SHLVL': '1', 21:47:00 INFO - 'TERM': 'linux', 21:47:00 INFO - 'TMOUT': '86400', 21:47:00 INFO - 'USER': 'cltbld', 21:47:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:00 INFO - '_': '/tools/buildbot/bin/python'} 21:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:00 INFO - Running setup.py (path:/tmp/pip-1mzmGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:00 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)) 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:00 INFO - Running setup.py (path:/tmp/pip-tiWIXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:00 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)) 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:00 INFO - Running setup.py (path:/tmp/pip-qFPWO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:00 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)) 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:00 INFO - Running setup.py (path:/tmp/pip-fhMYwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:00 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)) 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:00 INFO - Running setup.py (path:/tmp/pip-iKrTE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:00 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)) 21:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:00 INFO - Running setup.py (path:/tmp/pip-gyN7oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:01 INFO - Running setup.py (path:/tmp/pip-rp4oxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:01 INFO - Running setup.py (path:/tmp/pip-asPPh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:01 INFO - Running setup.py (path:/tmp/pip-iwcl8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:01 INFO - Running setup.py (path:/tmp/pip-xotWOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:01 INFO - Running setup.py (path:/tmp/pip-YvUMXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:01 INFO - Running setup.py (path:/tmp/pip-HGncXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:01 INFO - Running setup.py (path:/tmp/pip-_h7LIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:01 INFO - Running setup.py (path:/tmp/pip-7jwCQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:01 INFO - Running setup.py (path:/tmp/pip-W00wXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:01 INFO - Running setup.py (path:/tmp/pip-23LgUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:01 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)) 21:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:01 INFO - Running setup.py (path:/tmp/pip-uRqor9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:01 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)) 21:47:01 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)) 21:47:01 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)) 21:47:01 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)) 21:47:01 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)) 21:47:01 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)) 21:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:03 INFO - Downloading blessings-1.6.tar.gz 21:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:03 INFO - Installing collected packages: blessings 21:47:03 INFO - Running setup.py install for blessings 21:47:03 INFO - Successfully installed blessings 21:47:03 INFO - Cleaning up... 21:47:03 INFO - Return code: 0 21:47:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:04 INFO - Reading from file tmpfile_stdout 21:47:04 INFO - Current package versions: 21:47:04 INFO - argparse == 1.2.1 21:47:04 INFO - blessings == 1.6 21:47:04 INFO - blobuploader == 1.2.4 21:47:04 INFO - docopt == 0.6.1 21:47:04 INFO - manifestparser == 1.1 21:47:04 INFO - mozInstall == 1.12 21:47:04 INFO - mozcrash == 0.17 21:47:04 INFO - mozdebug == 0.1 21:47:04 INFO - mozdevice == 0.48 21:47:04 INFO - mozfile == 1.2 21:47:04 INFO - mozhttpd == 0.7 21:47:04 INFO - mozinfo == 0.9 21:47:04 INFO - mozleak == 0.1 21:47:04 INFO - mozlog == 3.2 21:47:04 INFO - moznetwork == 0.27 21:47:04 INFO - mozprocess == 0.22 21:47:04 INFO - mozprofile == 0.28 21:47:04 INFO - mozrunner == 6.11 21:47:04 INFO - mozscreenshot == 0.1 21:47:04 INFO - mozsystemmonitor == 0.3 21:47:04 INFO - moztest == 0.7 21:47:04 INFO - mozversion == 1.4 21:47:04 INFO - psutil == 3.1.1 21:47:04 INFO - requests == 1.2.3 21:47:04 INFO - wsgiref == 0.1.2 21:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:04 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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:47:04 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 21:47:04 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 21:47:04 INFO - Using env: {'DISPLAY': ':0', 21:47:04 INFO - 'HOME': '/home/cltbld', 21:47:04 INFO - 'LANG': 'en_US.UTF-8', 21:47:04 INFO - 'LANGUAGE': 'en_US:en', 21:47:04 INFO - 'LOGNAME': 'cltbld', 21:47:04 INFO - 'MAIL': '/var/mail/cltbld', 21:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:04 INFO - 'MOZ_NO_REMOTE': '1', 21:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:04 INFO - 'NO_EM_RESTART': '1', 21:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:04 INFO - 'PWD': '/builds/slave/test', 21:47:04 INFO - 'SHELL': '/bin/bash', 21:47:04 INFO - 'SHLVL': '1', 21:47:04 INFO - 'TERM': 'linux', 21:47:04 INFO - 'TMOUT': '86400', 21:47:04 INFO - 'USER': 'cltbld', 21:47:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:04 INFO - '_': '/tools/buildbot/bin/python'} 21:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 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)) 21:47:04 INFO - Cleaning up... 21:47:04 INFO - Return code: 0 21:47:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:47:04 INFO - Using env: {'DISPLAY': ':0', 21:47:04 INFO - 'HOME': '/home/cltbld', 21:47:04 INFO - 'LANG': 'en_US.UTF-8', 21:47:04 INFO - 'LANGUAGE': 'en_US:en', 21:47:04 INFO - 'LOGNAME': 'cltbld', 21:47:04 INFO - 'MAIL': '/var/mail/cltbld', 21:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:04 INFO - 'MOZ_NO_REMOTE': '1', 21:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:04 INFO - 'NO_EM_RESTART': '1', 21:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:04 INFO - 'PWD': '/builds/slave/test', 21:47:04 INFO - 'SHELL': '/bin/bash', 21:47:04 INFO - 'SHLVL': '1', 21:47:04 INFO - 'TERM': 'linux', 21:47:04 INFO - 'TMOUT': '86400', 21:47:04 INFO - 'USER': 'cltbld', 21:47:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:04 INFO - '_': '/tools/buildbot/bin/python'} 21:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:04 INFO - Downloading/unpacking jsonschema 21:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:47:06 INFO - Downloading/unpacking functools32 (from jsonschema) 21:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:06 INFO - Downloading functools32-3.2.3-2.tar.gz 21:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:47:06 INFO - warning: no files found matching '*.txt' 21:47:06 INFO - no previously-included directories found matching 'build' 21:47:06 INFO - no previously-included directories found matching 'dist' 21:47:06 INFO - no previously-included directories found matching '.git*' 21:47:06 INFO - Installing collected packages: jsonschema, functools32 21:47:06 INFO - Running setup.py install for functools32 21:47:06 INFO - warning: no files found matching '*.txt' 21:47:06 INFO - no previously-included directories found matching 'build' 21:47:06 INFO - no previously-included directories found matching 'dist' 21:47:06 INFO - no previously-included directories found matching '.git*' 21:47:06 INFO - Successfully installed jsonschema functools32 21:47:06 INFO - Cleaning up... 21:47:07 INFO - Return code: 0 21:47:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:07 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 0x7f7fb9dddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, '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': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', '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 21:47:07 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 21:47:07 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 21:47:07 INFO - Using env: {'DISPLAY': ':0', 21:47:07 INFO - 'HOME': '/home/cltbld', 21:47:07 INFO - 'LANG': 'en_US.UTF-8', 21:47:07 INFO - 'LANGUAGE': 'en_US:en', 21:47:07 INFO - 'LOGNAME': 'cltbld', 21:47:07 INFO - 'MAIL': '/var/mail/cltbld', 21:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:07 INFO - 'MOZ_NO_REMOTE': '1', 21:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:07 INFO - 'NO_EM_RESTART': '1', 21:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:07 INFO - 'PWD': '/builds/slave/test', 21:47:07 INFO - 'SHELL': '/bin/bash', 21:47:07 INFO - 'SHLVL': '1', 21:47:07 INFO - 'TERM': 'linux', 21:47:07 INFO - 'TMOUT': '86400', 21:47:07 INFO - 'USER': 'cltbld', 21:47:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:07 INFO - '_': '/tools/buildbot/bin/python'} 21:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:07 INFO - Downloading/unpacking flake8 21:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:47:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:47:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:47:09 INFO - no previously-included directories found matching 'docs/_build' 21:47:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:47:09 INFO - Running setup.py install for pep8 21:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:47:09 INFO - no previously-included directories found matching 'docs/_build' 21:47:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:47:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:47:10 INFO - Cleaning up... 21:47:10 INFO - Return code: 0 21:47:10 INFO - Running post-action listener: _resource_record_post_action 21:47:10 INFO - Running post-action listener: _start_resource_monitoring 21:47:10 INFO - Starting resource monitoring. 21:47:10 INFO - ##### 21:47:10 INFO - ##### Finished create-virtualenv step (success) 21:47:10 INFO - ##### 21:47:10 INFO - ##### 21:47:10 INFO - ##### Running install step. 21:47:10 INFO - ##### 21:47:10 INFO - Running pre-action listener: _resource_record_pre_action 21:47:10 INFO - Running main action method: install 21:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:10 INFO - Reading from file tmpfile_stdout 21:47:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:10 INFO - Reading from file tmpfile_stdout 21:47:10 INFO - Output received: 21:47:10 INFO - Usage: mozinstall [options] installer 21:47:10 INFO - Options: 21:47:10 INFO - -h, --help show this help message and exit 21:47:10 INFO - -d DEST, --destination=DEST 21:47:10 INFO - Directory to install application into. [default: 21:47:10 INFO - "/builds/slave/test"] 21:47:10 INFO - --app=APP Application being installed. [default: firefox] 21:47:10 INFO - mkdir: /builds/slave/test/build/application 21:47:10 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'] 21:47:10 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 21:47:26 INFO - Reading from file tmpfile_stdout 21:47:26 INFO - Output received: 21:47:26 INFO - /builds/slave/test/build/application/firefox/firefox 21:47:26 INFO - Running post-action listener: _resource_record_post_action 21:47:26 INFO - ##### 21:47:26 INFO - ##### Finished install step (success) 21:47:26 INFO - ##### 21:47:26 INFO - ##### 21:47:26 INFO - ##### Running run-tests step. 21:47:26 INFO - ##### 21:47:26 INFO - Running pre-action listener: _resource_record_pre_action 21:47:26 INFO - Running main action method: run_tests 21:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:26 INFO - Python 2.7.3 21:47:26 INFO - Return code: 0 21:47:26 INFO - grabbing minidump binary from tooltool 21:47: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')]} 21:47:26 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 0x1b3f9c0>, '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 0x1b408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b40d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:26 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 21:47:26 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 21:47:26 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 21:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:26 INFO - Return code: 0 21:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:47:27 INFO - Return code: 0 21:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 21:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 21:47:27 INFO - Using env: {'DISPLAY': ':0', 21:47:27 INFO - 'HOME': '/home/cltbld', 21:47:27 INFO - 'LANG': 'en_US.UTF-8', 21:47:27 INFO - 'LANGUAGE': 'en_US:en', 21:47:27 INFO - 'LOGNAME': 'cltbld', 21:47:27 INFO - 'MAIL': '/var/mail/cltbld', 21:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:27 INFO - 'MOZ_NO_REMOTE': '1', 21:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:27 INFO - 'NO_EM_RESTART': '1', 21:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:27 INFO - 'PWD': '/builds/slave/test', 21:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:27 INFO - 'SHELL': '/bin/bash', 21:47:27 INFO - 'SHLVL': '1', 21:47:27 INFO - 'TERM': 'linux', 21:47:27 INFO - 'TMOUT': '86400', 21:47:27 INFO - 'USER': 'cltbld', 21:47:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463369065.140134-783371218', 21:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:27 INFO - '_': '/tools/buildbot/bin/python'} 21:47:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 21:47:27 INFO - mozversion application_buildid: 20160515203829 21:47:27 INFO - mozversion application_changeset: d0be57e84807ce0853b2406de7ff6abb195ac898 21:47:27 INFO - mozversion application_display_name: Nightly 21:47:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:27 INFO - mozversion application_name: Firefox 21:47:27 INFO - mozversion application_remotingname: firefox 21:47:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:47:27 INFO - mozversion application_vendor: Mozilla 21:47:27 INFO - mozversion application_version: 49.0a1 21:47:27 INFO - mozversion platform_buildid: 20160515203829 21:47:27 INFO - mozversion platform_changeset: d0be57e84807ce0853b2406de7ff6abb195ac898 21:47:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:47:27 INFO - mozversion platform_version: 49.0a1 21:47:27 INFO - using testdate: 1463374047 21:47:27 INFO - actual date: 1463374047 21:47:27 INFO - starting webserver on 'localhost:60012' 21:47:27 INFO - SUITE-START | Running 2 tests 21:47:27 INFO - TEST-START | dromaeo_css 21:47:27 INFO - operating with platform_type : linux_ 21:47:27 INFO - Initialising browser for dromaeo_css test... 21:47:27 INFO - TEST-INFO | started process 18392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PGjWo/profile http://localhost:60012/getInfo.html) 21:47:31 INFO - PROCESS | 18392 | 21:47:31 INFO - PROCESS | 18392 | (process:18457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:47:32 INFO - PROCESS | 18392 | __metrics Screen width/height:1600/1200 21:47:32 INFO - PROCESS | 18392 | colorDepth:24 21:47:32 INFO - PROCESS | 18392 | Browser inner width/height: 1024/697 21:47:32 INFO - PROCESS | 18392 | __metrics 21:47:32 ERROR - PROCESS | 18392 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 21:47:33 INFO - TEST-INFO | 18392: exit 0 21:47:33 INFO - Browser initialized. 21:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:33 INFO - TEST-INFO | started process 18508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PGjWo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:35 INFO - PROCESS | 18508 | 21:47:35 INFO - PROCESS | 18508 | (process:18569): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:47:45 INFO - PROCESS | 18508 | RSS: Main: 164749312 21:47:45 INFO - PROCESS | 18508 | 21:48:35 INFO - PROCESS | 18508 | 1463374115294 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] 21:50:46 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60012/tests/dromaeo/cssquery-ext.html) 21:50:48 INFO - PROCESS | 18508 | RSS: Main: 165793792 21:50:48 INFO - PROCESS | 18508 | 21:53:50 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-ext.html (next: http://localhost:60012/tests/dromaeo/cssquery-jquery.html) 21:53:50 INFO - PROCESS | 18508 | RSS: Main: 166227968 21:53:50 INFO - PROCESS | 18508 | 21:56:52 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60012/tests/dromaeo/cssquery-mootools.html) 21:56:53 INFO - PROCESS | 18508 | RSS: Main: 167661568 21:56:53 INFO - PROCESS | 18508 | 21:59:55 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60012/tests/dromaeo/cssquery-prototype.html) 21:59:55 INFO - PROCESS | 18508 | RSS: Main: 165220352 21:59:55 INFO - PROCESS | 18508 | 22:02:58 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60012/tests/dromaeo/cssquery-yui.html) 22:02:59 INFO - PROCESS | 18508 | RSS: Main: 166174720 22:02:59 INFO - PROCESS | 18508 | 22:06:01 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:60012/tests/dromaeo/cssquery-yui.html (next: http://localhost:60012/tests/dromaeo/cssquery-dojo.html) 22:06:02 INFO - PROCESS | 18508 | RSS: Main: 168202240 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | __start_tp_report 22:06:02 INFO - PROCESS | 18508 | _x_x_mozilla_page_load 22:06:02 INFO - PROCESS | 18508 | _x_x_mozilla_page_load_details 22:06:02 INFO - PROCESS | 18508 | |i|pagename|runs| 22:06:02 INFO - PROCESS | 18508 | |0;dojo.html;2659.202239328202;2689.623452716621;2714.809963302569;2728.4406696627193;2747.6840163381216;4670.089332580144;4709.434867815862;4778.880527986802;4804.495527969565;4806.759662016894;4602.493725690171;4760.024195040017;4797.736124513151;4806.663533552644;4808.471068182497;4347.304431291002;4445.377647129404;4507.819687212507;4514.638828893697;4520.412346394964;504.8562774338135;4333.090051089275;4421.292593185091;4453.84411545596;4454.844080457185;4391.6267117295065;4458.621017213524;4462.754548499831;4466.955330446686;4489.057297967447;4311.6335111515555;4442.800073996678;4457.78351026887;4463.196624607569;4467.530909254514;4311.48262208537;4328.913421731548;4339.1104823511105;4383.517813040563;4404.823807047715;4584.106099310636;4610.723356598582;4628.907421851544;4629.282461218483;4663.417072865892;4968.527989840959;5053.873653158664;5065.848024559269;5105.617078719111;5116.488351164891;5151.098557752378;5200.947990520084;5202.843914682528;5203.531682148625;5254.185601231777;4815.5906747926465;4822.879428014293;4829.227323628203;4857.101436234308;4866.124097662419;5038.647294689336;5229.633925625246;5246.868828279247;5283;5308.23030660552;5066.113430149709;5082.720450375191;5084.65267688187;5092.490750924952;5101.2603172539775;5177;5179.430262671103;5180.922286165711;5185.196294574347;5214.504622060898;4953.0589188054155;5066.949330506722;5105.795768169306;5124.974375128175;5149.639525233198;4892.241702536113;4955.90088198234;4963.106640804617;4990.451050384455;4991.650584459126;4251.766152861623;4259.531451540328;4261.169072030986;4308.116836048603;4313.309870420718;3649.616790236987;3782.167923056923;3793.7723736575895;3810.7141964352786;3841.9039524011564;4535.365048893158;4538.750368729686;4540.387047748512;4577.29051996941;4587.105514424655;4991.575716064102;5199.142141546678;5254.133068043807;5264.92102618461;5282.049231138432;4400.867973960786;4421.292593185075;4463.977680111579;4480.991776850183;4484.484284307347;4598.908021839545;4599.0342028174455;4612.123696497655;4626.884327891829;4656.557627025427;4855.611551075976;4864.82973095947;4881.755912204376;4886.315915771724;4920.581750551171;5027.2207807789855;5146.0479811233545;5183.403908550565;5193.584513238856;5199.324087868704;4939.333190019302;4942.481039490802;4961.950380496149;4962.627802914723;4989.451160372429;4866.197077482176;5110.514501122388;5113.360829896263;5116.130257856248;5125.564327032244;5122.410922743932;5148.613853960893;5178.223266510054;5184.585233181412;5204;5002;5035.697858128524;5036.8992620146655;5043.798248070036;5073.188289873602;4866.756662166807;4980.128477516348;5014.122528557415;5031.195008798574;5045.596352291881;4949.604031677385;4954.603631709527;4994.9500504994485;5013.924791128063;5054.848354549369;4982.352294201731;5021.698698078127;5024.045431368028;5065.7720402581235;5073.416557095834;4759.833405830779;4934.7285899275885;4953.801847926186;4957.652964292465;5003.44962054181 22:06:02 INFO - PROCESS | 18508 | |1;ext.html;557.3646043510396;597.674267524199;600.0219641983566;611.7797592866568;627.6108812536228;36413.81793091034;40825.97935051625;40836;40890.59109408905;41000.58999410005;41839;42309.57690423095;42320.78839605805;42460.787696061554;42475.362869556906;7920.16838231986;8002.759917202493;8095.757127286191;8096.716614918479;8097.838043239161;7900.32847207988;7910.960445197795;7946.324562412202;7989.800254993643;7999.080105787822;7974.681012759483;7980.3615710743;8012.879806802903;8021.19788021199;8022.19778022199;7904.09102953162;7975;7990.680372785082;8003.95998020012;8014.639341229658;7983.3214176795045;7992.360611151152;8046.8792968104935;8062.032556093248;8063.1130575636635;30423.23941901448;38109.428358574645;38197.23605527902;38288.80855595732;38331.61668383308;3096.6438859531218;3101.5967924169713;3116.67274936133;3153.8896138635037;3251.430999575065;28905;28952.71047289521;29049.273768155756;29115.272118197;30240;3366.5286859839644;3388.4268659545896;3408.5739282589675;3494.0391392367046;3504.0188747150837;251272;251625;252246;252880.7355963227;253724;34303.65696343055;34306.313873722385;34318;34361;34599.30801383958;34698.826505867306;36480.27039459196;36648;36682.63317366792;36694.26611467756;14161.575152745434;14367.78448323276;14403.135811851322;14440.85559144416;14453.349599267847;11629;11736.58921937745;11776;11800.350980696145;11804.822927656092;8399.160083991552;8458.196471335214;8459.619317130744;8521.786955326166;8545.957270213608;3356.8992930212135;3360.327934413127;3379.087646335525;3394.304167645676;3396.7961922284744;932.978388664425;938.2447130060367;956.784723437221;981.7300242433245;1014.1785154025263;28448.288792780346;29120;29337.853310733735;29428.558571621445;29651.703482964895;984.178211193647;1014.2190513304714;1021.9897801022043;1028.2647906746713;1047.209356935524;15361.846381536265;15724.764128538081;15845.445409410615;15920.601984950237;16079.67840643204;407377;409410;410232;410914;411545;52167.217491737654;52472.21291680628;52526.47473525292;52807.735961320715;52895;1256.8491780986158;1278.3288773394042;1297.6561211279018;1308.3981368570564;1310.3186343101534;28435.715642844134;28886.277843054093;29050.12890003566;29329.706702933552;29723.702762972094;43042.56957430511;43556.34665479957;43873.78063109664;43897.34153987629;44012.779936100116;329190;334431;336193;336217;336654;26334.341641459116;26559.33601659974;26690.7330926696;26732.732672673803;26890.731092688824;42040.1591968165;42762.57237427586;43018.56981430146;43268.78365608278;43344.78327608342;35727;36880.07799805026;37123.44314835333;37182.44226336553;37539.24921501609;36389.45415818818;36410.45384319184;36776.816115919246;37047.81476092602;37295;36269.63730362662;38233.617663824116;38883;39083.80458097691;41627;31198.532022019233;34619.48070778991;34807.30385392329;35007.12482187965;35328.29343413169;26212.606810898233;26777.33056673599;26888.865555672095;26891.731082689705;27165 22:06:02 INFO - PROCESS | 18508 | |2;jquery.html;377.69218087258866;379.73608342202164;384.724921680998;393.462923109955;400.69346949583576;16137.273822677978;17398.13009349532;17507.562310942234;18140.546486337847;18189.18148683309;16493.17534123292;17091.57271068221;17852.732209016875;18135.183916723745;18158.81841181588;5205.063088644042;5357.035733567956;5382.058139825534;5404.83785486436;5413.864653383657;3726.906827329325;5766.365699773021;6137.324894261627;6139.570230083896;6242.563020588561;6016.578839481238;6039.765286843874;6188.381161883821;6194.039923811816;6195.349488303731;6154.138420621117;6160.229971253593;6196.721147548348;6203.503719702413;6206.441420272175;4682.531746825291;4974.701517908901;5006.098902197603;5358.624896257264;5395.622306438551;12987.480500779957;13057.608271751862;13553.119047261896;20656.380308590768;21086.683699744517;1878.3238034307637;1921.9135138918782;1924.6535623587888;2025.706272590481;2045.5397535554382;8884.422512536728;9230.123138301851;9634;9775.755606109833;11289.548418063268;1673.4644913627521;1697.125980120239;1733.4452975047864;1743.7210046392515;1766.3199668127734;69427.65286173587;71001;73073.63463182704;73394;75761;9828.557714902703;10050.145737612238;10176.13502852251;10408.907064758243;10426.5829366826;14336.139831610137;14339.856601434061;14379.352929118215;14381.64045898861;14432.917531185203;7278.235785242579;7381.520201186906;7399.8150046249275;7481.765508691005;7577.128630207597;7046.5067445279365;7118.074650295532;7186.353228209487;7230.855382892312;7253.818654533573;4461.397711308997;4492.146492166478;4537.863864084083;4601.5168407317415;4618.815247390134;1725.9654806904043;1797.6135130946648;1911.6845720456247;1914.7606549181353;1925.5956249187827;893.9374243803002;916.408916249029;934.5887809363858;975.6000039983714;1032.2722480651123;16926.153692315336;16969.575760605836;16991.575210619834;17042.829571704373;17176.39882604103;902.670525258276;927.1933417926447;934.1219253901311;1012.3022145981025;1025.6769117727893;9558.474283914451;9603.327767056378;9642.903570964341;9656.27577931658;9785.26610504215;411054;435439;436713;441942;449485;86680;89047;89809;90407.54796225976;90638.54680726553;965.2953344058736;969.9224062074876;970.7767213540925;970.8786401699788;972.2999440402899;15628.92185539065;15817.209139543207;15834.786562667245;15929.20353982273;15943;36958;37247.6963306283;38327.616723832405;38742.80628596952;39135.6086439132;52606;55010;55095.21500242577;55266.44733552613;55443.72278138583;7565.130010048915;7721.7683469496005;7936.84126317482;7964.960175199087;8060.31487323584;11025.117990560897;11193.328400296008;11664.766704666028;12047.638570842888;12583.496660133493;5882.794102206402;6947.826304342229;10160.695179144637;10232.181425485795;10624.415657138932;10265.948670256601;10389.168866490814;10398.27212095146;10616.097631701392;10728.302660327054;4825.203841366276;5993.61041532299;10360.637377691744;10565.418901960466;10601.144799660184;7609.733659322119;7665;7690.807729806799;7713.267239612228;7744.070711514654;9715.562799674173;10470.319429237075;10471.424071675827;10714.785704286027;10726.410047447465 22:06:02 INFO - PROCESS | 18508 | |3;mootools.html;1502.9849701502985;1527.9923600381999;1729.4206440842318;1881.7835948865868;1891.3852997775718;6794.96602516988;7829.491083079603;7846.72536461224;8357.038940521841;8359.4566353187;7932.087809901863;8109.4323397362205;8156.265936065753;8239.258466737992;8255.133211012831;2306.3542208181693;2342.402687314741;2347.307544274435;2350.647402889572;2353.082297903819;2282.5092605089903;2312.5490529346785;2337.91817286395;2351.412146963259;2356.06935260572;2219.711437513121;2229.57638048771;2244.3267019894047;2345.061975209921;2348.4833336665906;2207.9448013799624;2244.9448759083284;2245.1692873636694;2245.236619549353;2248.4828489447355;2219.8002179803893;2238.8432809703327;2240.0703707961175;2244.3827947314458;2258.232201051634;8130.30892374143;8224.218699223564;8225.300849427806;8226.794330141734;8232.62953167109;4679.555442232982;4745.905081898377;4763.49983251757;4767.213409787381;4789.928151077736;2906.084583356257;2907.563865420204;3100.58142150809;3109.347037122207;3127.6090488688915;922.0733163171037;955.7467271173144;960.0639376607821;978.2467500024941;979.2557656181282;10375.533101010396;10417.843732344021;10449.895501044968;10548.525316360781;10558.947205264001;4299.419578356944;4322.481302243688;4411.360352748898;4449;4518.209313370147;9117.81764364709;9122.589483473259;9122.954385228164;9142.451452912846;9144.451332920045;4870.878228044327;4894.363732714724;4896.755162241873;4899.8285060023445;4903.141950158708;3808.200277941608;4260.595243451867;4363.38912552243;4475.865724028285;4479.395281636937;3785.564660064128;3817.9618203818163;3903.6291552303055;3944.073142811437;3948.486696729407;1270.1870802686287;1270.4727538071782;1277.3613193403298;1277.6294874486296;1291.231717128307;652.3704625036862;764.9885251721229;796.1680044353549;803.7146812881343;878.2052242720348;5050.141475949097;5148.6910785353;5159.871003224949;5163.715995620277;5398.676079435247;878.8813510176172;925.5788616179622;926.5969303353063;937.7749340158313;939.1359948847077;3392.643772403862;3399.8300084995653;3406.080358303294;3499.68502834741;3504.053905445566;9564.904350956402;9789.608415663293;9843.458609776531;9887.159591434809;9897.703068907944;9739.65911193119;9865.605375785031;9887.703368898945;9915.652952146784;9924.1068303853;7116.857662846817;7242.674079666428;7328.157261914841;7364.631768411558;7423.072115985394;5448.318960129984;5493.285872836505;5520.779168833202;5563.666180029211;5717.256756621613;8792.208701216921;8894.644214231617;8943.150400711922;8961.50711710836;9062.365634405529;8868.423552469068;9070.682526111554;9148.359614826899;9169.862452063358;9228.169464748205;6274.309825919237;6827.965860170866;7023.859522809617;7047.47143964215;7230.276972302728;7830.804229894298;7896.368290536629;7929.603519824101;7957.562334071682;7995.640196191302;7045.260247674126;7173.641317933978;7179.246179151322;7241.927580724126;7299.233580474186;7087.7164913402885;7089.220185779457;7146.499745017799;7201.81995450097;7230.927690723025;6385.233771947396;6618.139641846529;6622.933770662425;6768.1878174617395;6784.219814721173;4583.679142459996;4662.93005604923;4688;4693.5071817458675;4718.292256161603;4720.12677654635;4726;4744.312074749211;4757.286407038833;4803.639727020557 22:06:02 INFO - PROCESS | 18508 | |4;prototype.html;319.5047676102041;319.85766333981377;325.0670575448463;326.3456769177798;326.9803811771295;5070.163423035199;5071.898562028762;5084.593232541397;5136.871578210537;5154.355705536808;5018.623603229754;5028.220625802997;5043.546080852722;5060.215666571678;5105.6936583805;3784.3566593679143;3859.9614003860024;3926.509186351706;3949.9802500987453;3972.7616343019513;3936.2914675358425;3938.448617193595;3965.702572307074;3976.741511801738;3983.223271462066;3958.307296223164;3963.1479231965122;3976.7216294859372;3985.8804235872826;3998.140864498008;3785.886423407302;3941.625545573166;3962.8414863405287;3983.7410568312966;3994.6604538614106;3504.2115524006895;3526.418141006731;3536.1159710072484;3537.5047493350953;3538.292341531704;4776.140294746944;4799;4818.566329030404;4852.490488498727;4902.28916807061;4418.801153948048;4521.231390663595;4526.637868970474;4536.319552067183;4538.863834084983;5182.305201295306;5203.661761985459;5211.661242019257;5214.191800270926;5230.320058392423;3796.8101594920417;3804.6766024887916;3810.1046254130256;3855.768653880748;3857.1707082977014;5383.273258110184;5523.2543606613;5539.639923404966;5546.251256080418;5566.359868615121;3887.8639247626197;3929.8975048349566;3931.0958479549863;3937.625925537069;3956.8039737945714;3974.5429275633096;3978.9403158952637;4012.776103288525;4017.1764788218347;4018.819153138116;4450.666200034945;4511.571400716926;4518.141553104965;4531.43357080365;4569.063342014879;5088.160453525201;5193.974030129825;5209.713465759344;5247.63266571344;5270.736463176826;1361.9250941198131;1364.9830875997247;1367.6444124527695;1370.9383077761524;1384.8268966379203;880.6345366672887;898.5776684958059;899.2086963472103;906.664534122379;907.5598334807613;4595.471520775087;4655.441347038377;4657.254839225708;4692.788824502905;4702.27114797207;5329.973350133225;5331.226972089025;5401.756920938567;5413.756380962787;5469.2616496772425;4500.684952053325;4667.533246675305;4673.813047478131;4690.64820138491;4754.5245475452175;2890.4941635213754;2916.4251304295867;2922.7286130533284;2933.7066293370917;2939.9265018374713;5140.6634275088745;5154.252633368141;5164.54684025085;5189.922151167735;5190.6107041972;5365.1907145926825;5570.498655120978;5572.721363931787;5577.944220557823;5598.384177740445;5147.150720131286;5162.74186290684;5163.3545806774155;5163.896722065613;5175;5448.618596698193;5451.536619387396;5464.398916119144;5489.698066606375;5492.862678433071;5098.592112630907;5345.492178243061;5385.703786291635;5398.568114550748;5415.564875308125;5161.66449180802;5164.122099243213;5190.792368305226;5191.402988656353;5213.973930130325;3817.541894972621;3857.2285542890972;3882.359410697203;3891.7859517726797;3920.411938209177;5211.661242019257;5462.8907421850545;5466.289382380424;5471.151971444432;5592.832215033555;5240.34495688039;5286.97356513215;5287.52412282881;5294.391145018372;5307.495787900143;5123.769430375568;5266.815661451831;5267.86740850719;5279.736013199248;5313.203019547099;5170.27616133734;5212.192110222922;5215.461438875465;5221.973890130677;5223.921641175461;5124.9743751281;5147.2536482209125;5354.919676204782;5376.193570964387;5377.596680249075;5208.427073021889;5209.921851172311;5227.555657769132;5248.317718696698;5248.895022099613 22:06:02 INFO - PROCESS | 18508 | |5;yui.html;732.3994324653783;737.9889301660476;782.5070205770365;801.6913488307003;821.2690705272305;11214;12017.519299228032;12896.548620798285;13300.268485233308;13321.467141314335;15028.624284392869;15049.24753762313;15089.320980555874;15158.317875695593;15170.089794612331;688.0711040095881;879.1428357351595;894.5661354243219;897.4615230861464;898.5237823953315;858.5578427110012;885.3935054487664;886.8448021596228;888.9377743557953;889.9555022248861;932.2635118256569;933.4772527384653;937.69524904406;938.061938061938;940.3464592108487;916.7845556294266;921.6866265469705;922.3543519536317;923.7967647117623;925.745420009496;677.6408503493157;684.0696652552524;684.650828077679;684.7192651013111;684.7637565040053;13458.327083645778;13512.594622161252;13535.052546321762;13537.1200871944;13548.187108773505;12389.690257743538;12604.55884044054;12605.243685378815;12651.683707907376;12777;10088.697339079767;10294.691159265234;10478.10936070435;10530.15758739299;10594.152467802558;3286.6877646623534;3310.304835984422;3320.568326117613;3348.866045358207;3377.358301922651;51529;51830;51906.74046629781;52421;53363.999999999614;9974.353089105627;10026.19790416765;10079.5464204111;10105.545250463747;10359.223058270509;18145.274189032556;18149.092545372943;18175.363862264756;18186.45440636783;18201.817981820277;6541.6402097885075;6618.106555614931;6650.833729156713;6728.6635668216395;6828.5220034597105;3752.2120354725266;3766;3817.7136714746507;3832.5400951885954;3862.8841134766003;2786.400923801352;2872.856357182174;2873.913782586526;2886.0620298403105;2934.5598160275704;579.2209478251744;580.0255570641278;589.5313225985352;597.2206270816539;605.0138274612442;515.2245869965677;565.7284503438373;577.4110407384528;598.7515181199753;603.0270765127874;8538.53038082899;8767.736967890845;8834;8928.955355223183;8963.865542016874;498.3869840096629;510.26474318325995;599.409581562161;613.7882430561449;620.5221979076086;4005.5193376794386;4042.4542686737504;4090.8568200112854;4171.666266698718;4532.886677833015;49860.25209621859;51570.484295156566;51778;58190.4180958185;61613.69193154005;51282.23076653779;52170;53049;53787.462125379025;54175.18737218945;49967.503574606766;50016.99966000659;50427.24359134616;50777.74611126921;51141.74429127831;8732.91267087321;8855;8865.157810008039;8866.866996995179;8978.506182160045;32347;32578.185545361557;32686.83656581702;33051.17372065622;33067.33865322632;37996.62003379931;40675;41174.79412603038;41379.58620413878;41869;11800;11898.22661526998;11972.102092343282;12032.75934481288;12276.631701048982;11893.881061189277;12035.819462707892;12064.698382540506;12200.633980980585;12257.38713064361;11797.646070617895;11924.70188245266;12193.939030304791;12300.753984920073;12507.187032842836;11398.430078496207;11416.885831141582;11596.652100437;11655.417229138679;11729.178957472895;11074.280171788809;11425.31448113116;11640;11736.675868586566;11966.282023078295;9482.336236463381;9703.708888733348;9846.60613575449;9915.950420247853;10179.98200179976;9718.465484398426;9828.239065811042;9871.605135794487;9927.156191723785;10002.499875006366 22:06:02 INFO - PROCESS | 18508 | __end_tp_report 22:06:02 INFO - PROCESS | 18508 | __start_cc_report 22:06:02 INFO - PROCESS | 18508 | _x_x_mozilla_cycle_collect,377 22:06:02 INFO - PROCESS | 18508 | __end_cc_report 22:06:02 INFO - PROCESS | 18508 | __startTimestamp1463375162030__endTimestamp 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | ------- Summary: start ------- 22:06:02 INFO - PROCESS | 18508 | Number of tests: 6 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#0] dojo.html Cycles:165 Average:4723.93 Median:4920.58 stddev:596.91 (12.1%) stddev-sans-first:576.34 22:06:02 INFO - PROCESS | 18508 | Values: 2659.2 2689.6 2714.8 2728.4 2747.7 4670.1 4709.4 4778.9 4804.5 4806.8 4602.5 4760.0 4797.7 4806.7 4808.5 4347.3 4445.4 4507.8 4514.6 4520.4 504.9 4333.1 4421.3 4453.8 4454.8 4391.6 4458.6 4462.8 4467.0 4489.1 4311.6 4442.8 4457.8 4463.2 4467.5 4311.5 4328.9 4339.1 4383.5 4404.8 4584.1 4610.7 4628.9 4629.3 4663.4 4968.5 5053.9 5065.8 5105.6 5116.5 5151.1 5200.9 5202.8 5203.5 5254.2 4815.6 4822.9 4829.2 4857.1 4866.1 5038.6 5229.6 5246.9 5283.0 5308.2 5066.1 5082.7 5084.7 5092.5 5101.3 5177.0 5179.4 5180.9 5185.2 5214.5 4953.1 5066.9 5105.8 5125.0 5149.6 4892.2 4955.9 4963.1 4990.5 4991.7 4251.8 4259.5 4261.2 4308.1 4313.3 3649.6 3782.2 3793.8 3810.7 3841.9 4535.4 4538.8 4540.4 4577.3 4587.1 4991.6 5199.1 5254.1 5264.9 5282.0 4400.9 4421.3 4464.0 4481.0 4484.5 4598.9 4599.0 4612.1 4626.9 4656.6 4855.6 4864.8 4881.8 4886.3 4920.6 5027.2 5146.0 5183.4 5193.6 5199.3 4939.3 4942.5 4962.0 4962.6 4989.5 4866.2 5110.5 5113.4 5116.1 5125.6 5122.4 5148.6 5178.2 5184.6 5204.0 5002.0 5035.7 5036.9 5043.8 5073.2 4866.8 4980.1 5014.1 5031.2 5045.6 4949.6 4954.6 4995.0 5013.9 5054.8 4982.4 5021.7 5024.0 5065.8 5073.4 4759.8 4934.7 4953.8 4957.7 5003.4 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#1] ext.html Cycles:180 Average:47703.84 Median:36412.14 stddev:89356.69 (245.4%) stddev-sans-first:89537.25 22:06:02 INFO - PROCESS | 18508 | Values: 557.4 597.7 600.0 611.8 627.6 36413.8 40826.0 40836.0 40890.6 41000.6 41839.0 42309.6 42320.8 42460.8 42475.4 7920.2 8002.8 8095.8 8096.7 8097.8 7900.3 7911.0 7946.3 7989.8 7999.1 7974.7 7980.4 8012.9 8021.2 8022.2 7904.1 7975.0 7990.7 8004.0 8014.6 7983.3 7992.4 8046.9 8062.0 8063.1 30423.2 38109.4 38197.2 38288.8 38331.6 3096.6 3101.6 3116.7 3153.9 3251.4 28905.0 28952.7 29049.3 29115.3 30240.0 3366.5 3388.4 3408.6 3494.0 3504.0 251272.0 251625.0 252246.0 252880.7 253724.0 34303.7 34306.3 34318.0 34361.0 34599.3 34698.8 36480.3 36648.0 36682.6 36694.3 14161.6 14367.8 14403.1 14440.9 14453.3 11629.0 11736.6 11776.0 11800.4 11804.8 8399.2 8458.2 8459.6 8521.8 8546.0 3356.9 3360.3 3379.1 3394.3 3396.8 933.0 938.2 956.8 981.7 1014.2 28448.3 29120.0 29337.9 29428.6 29651.7 984.2 1014.2 1022.0 1028.3 1047.2 15361.8 15724.8 15845.4 15920.6 16079.7 407377.0 409410.0 410232.0 410914.0 411545.0 52167.2 52472.2 52526.5 52807.7 52895.0 1256.8 1278.3 1297.7 1308.4 1310.3 28435.7 28886.3 29050.1 29329.7 29723.7 43042.6 43556.3 43873.8 43897.3 44012.8 329190.0 334431.0 336193.0 336217.0 336654.0 26334.3 26559.3 26690.7 26732.7 26890.7 42040.2 42762.6 43018.6 43268.8 43344.8 35727.0 36880.1 37123.4 37182.4 37539.2 36389.5 36410.5 36776.8 37047.8 37295.0 36269.6 38233.6 38883.0 39083.8 41627.0 31198.5 34619.5 34807.3 35007.1 35328.3 26212.6 26777.3 26888.9 26891.7 27165.0 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#2] jquery.html Cycles:180 Average:26091.93 Median:227011.43 stddev:71959.44 (31.7%) stddev-sans-first:72135.41 22:06:02 INFO - PROCESS | 18508 | Values: 377.7 379.7 384.7 393.5 400.7 16137.3 17398.1 17507.6 18140.5 18189.2 16493.2 17091.6 17852.7 18135.2 18158.8 5205.1 5357.0 5382.1 5404.8 5413.9 3726.9 5766.4 6137.3 6139.6 6242.6 6016.6 6039.8 6188.4 6194.0 6195.3 6154.1 6160.2 6196.7 6203.5 6206.4 4682.5 4974.7 5006.1 5358.6 5395.6 12987.5 13057.6 13553.1 20656.4 21086.7 1878.3 1921.9 1924.7 2025.7 2045.5 8884.4 9230.1 9634.0 9775.8 11289.5 1673.5 1697.1 1733.4 1743.7 1766.3 69427.7 71001.0 73073.6 73394.0 75761.0 9828.6 10050.1 10176.1 10408.9 10426.6 14336.1 14339.9 14379.4 14381.6 14432.9 7278.2 7381.5 7399.8 7481.8 7577.1 7046.5 7118.1 7186.4 7230.9 7253.8 4461.4 4492.1 4537.9 4601.5 4618.8 1726.0 1797.6 1911.7 1914.8 1925.6 893.9 916.4 934.6 975.6 1032.3 16926.2 16969.6 16991.6 17042.8 17176.4 902.7 927.2 934.1 1012.3 1025.7 9558.5 9603.3 9642.9 9656.3 9785.3 411054.0 435439.0 436713.0 441942.0 449485.0 86680.0 89047.0 89809.0 90407.5 90638.5 965.3 969.9 970.8 970.9 972.3 15628.9 15817.2 15834.8 15929.2 15943.0 36958.0 37247.7 38327.6 38742.8 39135.6 52606.0 55010.0 55095.2 55266.4 55443.7 7565.1 7721.8 7936.8 7965.0 8060.3 11025.1 11193.3 11664.8 12047.6 12583.5 5882.8 6947.8 10160.7 10232.2 10624.4 10265.9 10389.2 10398.3 10616.1 10728.3 4825.2 5993.6 10360.6 10565.4 10601.1 7609.7 7665.0 7690.8 7713.3 7744.1 9715.6 10470.3 10471.4 10714.8 10726.4 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#3] mootools.html Cycles:180 Average:5289.96 Median:5470.80 stddev:2907.23 (53.1%) stddev-sans-first:2901.45 22:06:02 INFO - PROCESS | 18508 | Values: 1503.0 1528.0 1729.4 1881.8 1891.4 6795.0 7829.5 7846.7 8357.0 8359.5 7932.1 8109.4 8156.3 8239.3 8255.1 2306.4 2342.4 2347.3 2350.6 2353.1 2282.5 2312.5 2337.9 2351.4 2356.1 2219.7 2229.6 2244.3 2345.1 2348.5 2207.9 2244.9 2245.2 2245.2 2248.5 2219.8 2238.8 2240.1 2244.4 2258.2 8130.3 8224.2 8225.3 8226.8 8232.6 4679.6 4745.9 4763.5 4767.2 4789.9 2906.1 2907.6 3100.6 3109.3 3127.6 922.1 955.7 960.1 978.2 979.3 10375.5 10417.8 10449.9 10548.5 10558.9 4299.4 4322.5 4411.4 4449.0 4518.2 9117.8 9122.6 9123.0 9142.5 9144.5 4870.9 4894.4 4896.8 4899.8 4903.1 3808.2 4260.6 4363.4 4475.9 4479.4 3785.6 3818.0 3903.6 3944.1 3948.5 1270.2 1270.5 1277.4 1277.6 1291.2 652.4 765.0 796.2 803.7 878.2 5050.1 5148.7 5159.9 5163.7 5398.7 878.9 925.6 926.6 937.8 939.1 3392.6 3399.8 3406.1 3499.7 3504.1 9564.9 9789.6 9843.5 9887.2 9897.7 9739.7 9865.6 9887.7 9915.7 9924.1 7116.9 7242.7 7328.2 7364.6 7423.1 5448.3 5493.3 5520.8 5563.7 5717.3 8792.2 8894.6 8943.2 8961.5 9062.4 8868.4 9070.7 9148.4 9169.9 9228.2 6274.3 6828.0 7023.9 7047.5 7230.3 7830.8 7896.4 7929.6 7957.6 7995.6 7045.3 7173.6 7179.2 7241.9 7299.2 7087.7 7089.2 7146.5 7201.8 7230.9 6385.2 6618.1 6622.9 6768.2 6784.2 4583.7 4662.9 4688.0 4693.5 4718.3 4720.1 4726.0 4744.3 4757.3 4803.6 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#4] prototype.html Cycles:180 Average:4405.97 Median:5078.25 stddev:1267.23 (25.0%) stddev-sans-first:1233.10 22:06:02 INFO - PROCESS | 18508 | Values: 319.5 319.9 325.1 326.3 327.0 5070.2 5071.9 5084.6 5136.9 5154.4 5018.6 5028.2 5043.5 5060.2 5105.7 3784.4 3860.0 3926.5 3950.0 3972.8 3936.3 3938.4 3965.7 3976.7 3983.2 3958.3 3963.1 3976.7 3985.9 3998.1 3785.9 3941.6 3962.8 3983.7 3994.7 3504.2 3526.4 3536.1 3537.5 3538.3 4776.1 4799.0 4818.6 4852.5 4902.3 4418.8 4521.2 4526.6 4536.3 4538.9 5182.3 5203.7 5211.7 5214.2 5230.3 3796.8 3804.7 3810.1 3855.8 3857.2 5383.3 5523.3 5539.6 5546.3 5566.4 3887.9 3929.9 3931.1 3937.6 3956.8 3974.5 3978.9 4012.8 4017.2 4018.8 4450.7 4511.6 4518.1 4531.4 4569.1 5088.2 5194.0 5209.7 5247.6 5270.7 1361.9 1365.0 1367.6 1370.9 1384.8 880.6 898.6 899.2 906.7 907.6 4595.5 4655.4 4657.3 4692.8 4702.3 5330.0 5331.2 5401.8 5413.8 5469.3 4500.7 4667.5 4673.8 4690.6 4754.5 2890.5 2916.4 2922.7 2933.7 2939.9 5140.7 5154.3 5164.5 5189.9 5190.6 5365.2 5570.5 5572.7 5577.9 5598.4 5147.2 5162.7 5163.4 5163.9 5175.0 5448.6 5451.5 5464.4 5489.7 5492.9 5098.6 5345.5 5385.7 5398.6 5415.6 5161.7 5164.1 5190.8 5191.4 5214.0 3817.5 3857.2 3882.4 3891.8 3920.4 5211.7 5462.9 5466.3 5471.2 5592.8 5240.3 5287.0 5287.5 5294.4 5307.5 5123.8 5266.8 5267.9 5279.7 5313.2 5170.3 5212.2 5215.5 5222.0 5223.9 5125.0 5147.3 5354.9 5376.2 5377.6 5208.4 5209.9 5227.6 5248.3 5248.9 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - PROCESS | 18508 | [#5] yui.html Cycles:180 Average:13898.26 Median:2515.64 stddev:16090.73 (639.6%) stddev-sans-first:16105.49 22:06:02 INFO - PROCESS | 18508 | Values: 732.4 738.0 782.5 801.7 821.3 11214.0 12017.5 12896.5 13300.3 13321.5 15028.6 15049.2 15089.3 15158.3 15170.1 688.1 879.1 894.6 897.5 898.5 858.6 885.4 886.8 888.9 890.0 932.3 933.5 937.7 938.1 940.3 916.8 921.7 922.4 923.8 925.7 677.6 684.1 684.7 684.7 684.8 13458.3 13512.6 13535.1 13537.1 13548.2 12389.7 12604.6 12605.2 12651.7 12777.0 10088.7 10294.7 10478.1 10530.2 10594.2 3286.7 3310.3 3320.6 3348.9 3377.4 51529.0 51830.0 51906.7 52421.0 53364.0 9974.4 10026.2 10079.5 10105.5 10359.2 18145.3 18149.1 18175.4 18186.5 18201.8 6541.6 6618.1 6650.8 6728.7 6828.5 3752.2 3766.0 3817.7 3832.5 3862.9 2786.4 2872.9 2873.9 2886.1 2934.6 579.2 580.0 589.5 597.2 605.0 515.2 565.7 577.4 598.8 603.0 8538.5 8767.7 8834.0 8929.0 8963.9 498.4 510.3 599.4 613.8 620.5 4005.5 4042.5 4090.9 4171.7 4532.9 49860.3 51570.5 51778.0 58190.4 61613.7 51282.2 52170.0 53049.0 53787.5 54175.2 49967.5 50017.0 50427.2 50777.7 51141.7 8732.9 8855.0 8865.2 8866.9 8978.5 32347.0 32578.2 32686.8 33051.2 33067.3 37996.6 40675.0 41174.8 41379.6 41869.0 11800.0 11898.2 11972.1 12032.8 12276.6 11893.9 12035.8 12064.7 12200.6 12257.4 11797.6 11924.7 12193.9 12300.8 12507.2 11398.4 11416.9 11596.7 11655.4 11729.2 11074.3 11425.3 11640.0 11736.7 11966.3 9482.3 9703.7 9846.6 9916.0 10180.0 9718.5 9828.2 9871.6 9927.2 10002.5 22:06:02 INFO - PROCESS | 18508 | -------- Summary: end -------- 22:06:02 INFO - PROCESS | 18508 | 22:06:02 INFO - TEST-INFO | 18508: exit 0 22:06:02 INFO - TEST-OK | dromaeo_css | took 1115462ms 22:06:02 INFO - TEST-START | kraken 22:06:02 INFO - operating with platform_type : linux_ 22:06:02 INFO - Initialising browser for kraken test... 22:06:02 INFO - TEST-INFO | started process 18742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuI_Suo/profile http://localhost:60012/getInfo.html) 22:06:06 INFO - PROCESS | 18742 | 22:06:06 INFO - PROCESS | 18742 | (process:18808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:06:07 INFO - PROCESS | 18742 | __metrics Screen width/height:1600/1200 22:06:07 INFO - PROCESS | 18742 | colorDepth:24 22:06:07 INFO - PROCESS | 18742 | Browser inner width/height: 1024/697 22:06:07 INFO - PROCESS | 18742 | __metrics 22:06:08 ERROR - PROCESS | 18742 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:06:09 INFO - TEST-INFO | 18742: exit 0 22:06:09 INFO - Browser initialized. 22:06:09 INFO - Running cycle 1/1 for kraken test... 22:06:09 INFO - TEST-INFO | started process 18859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuI_Suo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:11 INFO - PROCESS | 18859 | 22:06:11 INFO - PROCESS | 18859 | (process:18918): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:06:21 INFO - PROCESS | 18859 | RSS: Main: 164356096 22:06:21 INFO - PROCESS | 18859 | 22:06:24 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:24 INFO - PROCESS | 18859 | RSS: Main: 167645184 22:06:24 INFO - PROCESS | 18859 | 22:06:27 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-dft) 22:06:28 INFO - PROCESS | 18859 | RSS: Main: 168144896 22:06:28 INFO - PROCESS | 18859 | 22:06:31 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-fft) 22:06:32 INFO - PROCESS | 18859 | RSS: Main: 164794368 22:06:32 INFO - PROCESS | 18859 | 22:06:34 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60012/tests/kraken/driver.html?testName=audio-oscillator) 22:06:34 INFO - PROCESS | 18859 | RSS: Main: 164487168 22:06:34 INFO - PROCESS | 18859 | 22:06:37 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:37 INFO - PROCESS | 18859 | RSS: Main: 164978688 22:06:37 INFO - PROCESS | 18859 | 22:06:41 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:41 INFO - PROCESS | 18859 | RSS: Main: 164749312 22:06:41 INFO - PROCESS | 18859 | 22:06:45 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60012/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:45 INFO - PROCESS | 18859 | RSS: Main: 163041280 22:06:45 INFO - PROCESS | 18859 | 22:06:48 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60012/tests/kraken/driver.html?testName=json-parse-financial) 22:06:49 INFO - PROCESS | 18859 | RSS: Main: 163786752 22:06:49 INFO - PROCESS | 18859 | 22:06:51 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:51 INFO - PROCESS | 18859 | RSS: Main: 163999744 22:06:51 INFO - PROCESS | 18859 | 22:06:53 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:54 INFO - PROCESS | 18859 | RSS: Main: 164179968 22:06:54 INFO - PROCESS | 18859 | 22:06:56 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:57 INFO - PROCESS | 18859 | RSS: Main: 164618240 22:06:57 INFO - PROCESS | 18859 | 22:07:00 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:00 INFO - PROCESS | 18859 | RSS: Main: 164651008 22:07:00 INFO - PROCESS | 18859 | 22:07:03 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:04 INFO - PROCESS | 18859 | RSS: Main: 164409344 22:07:04 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:60012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60012/tests/kraken/driver.html?testName=ai-astar) 22:07:06 INFO - PROCESS | 18859 | RSS: Main: 166449152 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | __start_tp_report 22:07:06 INFO - PROCESS | 18859 | _x_x_mozilla_page_load 22:07:06 INFO - PROCESS | 18859 | _x_x_mozilla_page_load_details 22:07:06 INFO - PROCESS | 18859 | |i|pagename|runs| 22:07:06 INFO - PROCESS | 18859 | |0;ai-astar;115;119;106;114;115;115;108;112;113;113 22:07:06 INFO - PROCESS | 18859 | |1;audio-beat-detection;163;131;161;214;133;155;157;140;188;132 22:07:06 INFO - PROCESS | 18859 | |2;audio-dft;163;166;166;171;162;163;163;164;162;163 22:07:06 INFO - PROCESS | 18859 | |3;audio-fft;76;75;75;168;78;75;76;76;160;77 22:07:06 INFO - PROCESS | 18859 | |4;audio-oscillator;93;93;179;94;93;92;142;92;92;138 22:07:06 INFO - PROCESS | 18859 | |5;imaging-gaussian-blur;117;117;118;118;117;118;117;117;117;118 22:07:06 INFO - PROCESS | 18859 | |6;imaging-darkroom;148;147;148;146;147;146;147;146;147;147 22:07:06 INFO - PROCESS | 18859 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 22:07:06 INFO - PROCESS | 18859 | |8;json-parse-financial;63;64;65;68;63;63;64;63;64;64 22:07:06 INFO - PROCESS | 18859 | |9;json-stringify-tinderbox;64;64;64;65;64;65;65;64;64;63 22:07:06 INFO - PROCESS | 18859 | |10;stanford-crypto-aes;88;82;83;82;83;84;83;88;150;87 22:07:06 INFO - PROCESS | 18859 | |11;stanford-crypto-ccm;130;126;130;129;134;142;130;132;152;134 22:07:06 INFO - PROCESS | 18859 | |12;stanford-crypto-pbkdf2;172;170;173;168;168;168;170;174;172;169 22:07:06 INFO - PROCESS | 18859 | |13;stanford-crypto-sha256-iterative;66;67;66;69;66;67;68;68;69;67 22:07:06 INFO - PROCESS | 18859 | __end_tp_report 22:07:06 INFO - PROCESS | 18859 | __start_cc_report 22:07:06 INFO - PROCESS | 18859 | _x_x_mozilla_cycle_collect,960 22:07:06 INFO - PROCESS | 18859 | __end_cc_report 22:07:06 INFO - PROCESS | 18859 | __startTimestamp1463375226507__endTimestamp 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | ------- Summary: start ------- 22:07:06 INFO - PROCESS | 18859 | Number of tests: 14 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:3.71 (3.2%) stddev-sans-first:3.87 22:07:06 INFO - PROCESS | 18859 | Values: 115.0 119.0 106.0 114.0 115.0 115.0 108.0 112.0 113.0 113.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:159.00 stddev:26.73 (16.8%) stddev-sans-first:28.27 22:07:06 INFO - PROCESS | 18859 | Values: 163.0 131.0 161.0 214.0 133.0 155.0 157.0 140.0 188.0 132.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:2.75 (1.7%) stddev-sans-first:2.88 22:07:06 INFO - PROCESS | 18859 | Values: 163.0 166.0 166.0 171.0 162.0 163.0 163.0 164.0 162.0 163.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.16 (48.9%) stddev-sans-first:38.87 22:07:06 INFO - PROCESS | 18859 | Values: 76.0 75.0 75.0 168.0 78.0 75.0 76.0 76.0 160.0 77.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:92.50 stddev:31.02 (33.5%) stddev-sans-first:32.22 22:07:06 INFO - PROCESS | 18859 | Values: 93.0 93.0 179.0 94.0 93.0 92.0 142.0 92.0 92.0 138.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:07:06 INFO - PROCESS | 18859 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 22:07:06 INFO - PROCESS | 18859 | Values: 148.0 147.0 148.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:07:06 INFO - PROCESS | 18859 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.56 22:07:06 INFO - PROCESS | 18859 | Values: 63.0 64.0 65.0 68.0 63.0 63.0 64.0 63.0 64.0 64.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 22:07:06 INFO - PROCESS | 18859 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 64.0 63.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:83.50 stddev:20.86 (25.0%) stddev-sans-first:22.10 22:07:06 INFO - PROCESS | 18859 | Values: 88.0 82.0 83.0 82.0 83.0 84.0 83.0 88.0 150.0 87.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:133.00 stddev:7.67 (5.8%) stddev-sans-first:8.00 22:07:06 INFO - PROCESS | 18859 | Values: 130.0 126.0 130.0 129.0 134.0 142.0 130.0 132.0 152.0 134.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:2.22 (1.3%) stddev-sans-first:2.28 22:07:06 INFO - PROCESS | 18859 | Values: 172.0 170.0 173.0 168.0 168.0 168.0 170.0 174.0 172.0 169.0 22:07:06 INFO - PROCESS | 18859 | 22:07:06 INFO - PROCESS | 18859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.16 (1.7%) stddev-sans-first:1.13 22:07:06 INFO - PROCESS | 18859 | Values: 66.0 67.0 66.0 69.0 66.0 67.0 68.0 68.0 69.0 67.0 22:07:06 INFO - PROCESS | 18859 | -------- Summary: end -------- 22:07:06 INFO - PROCESS | 18859 | 22:07:07 INFO - TEST-INFO | 18859: exit 0 22:07:07 INFO - TEST-OK | kraken | took 64920ms 22:07:07 INFO - SUITE-END | took 1180s 22:07:08 INFO - Completed test suite (00:19:40) 22:07:08 INFO - javascript benchmark 22:07:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6458.695568849588, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.202239328202, 2689.623452716621, 2714.809963302569, 2728.4406696627193, 2747.6840163381216, 4670.089332580144, 4709.434867815862, 4778.880527986802, 4804.495527969565, 4806.759662016894, 4602.493725690171, 4760.024195040017, 4797.736124513151, 4806.663533552644, 4808.471068182497, 4347.304431291002, 4445.377647129404, 4507.819687212507, 4514.638828893697, 4520.412346394964, 504.8562774338135, 4333.090051089275, 4421.292593185091, 4453.84411545596, 4454.844080457185, 4391.6267117295065, 4458.621017213524, 4462.754548499831, 4466.955330446686, 4489.057297967447, 4311.6335111515555, 4442.800073996678, 4457.78351026887, 4463.196624607569, 4467.530909254514, 4311.48262208537, 4328.913421731548, 4339.1104823511105, 4383.517813040563, 4404.823807047715, 4584.106099310636, 4610.723356598582, 4628.907421851544, 4629.282461218483, 4663.417072865892, 4968.527989840959, 5053.873653158664, 5065.848024559269, 5105.617078719111, 5116.488351164891, 5151.098557752378, 5200.947990520084, 5202.843914682528, 5203.531682148625, 5254.185601231777, 4815.5906747926465, 4822.879428014293, 4829.227323628203, 4857.101436234308, 4866.124097662419, 5038.647294689336, 5229.633925625246, 5246.868828279247, 5283.0, 5308.23030660552, 5066.113430149709, 5082.720450375191, 5084.65267688187, 5092.490750924952, 5101.2603172539775, 5177.0, 5179.430262671103, 5180.922286165711, 5185.196294574347, 5214.504622060898, 4953.0589188054155, 5066.949330506722, 5105.795768169306, 5124.974375128175, 5149.639525233198, 4892.241702536113, 4955.90088198234, 4963.106640804617, 4990.451050384455, 4991.650584459126, 4251.766152861623, 4259.531451540328, 4261.169072030986, 4308.116836048603, 4313.309870420718, 3649.616790236987, 3782.167923056923, 3793.7723736575895, 3810.7141964352786, 3841.9039524011564, 4535.365048893158, 4538.750368729686, 4540.387047748512, 4577.29051996941, 4587.105514424655, 4991.575716064102, 5199.142141546678, 5254.133068043807, 5264.92102618461, 5282.049231138432, 4400.867973960786, 4421.292593185075, 4463.977680111579, 4480.991776850183, 4484.484284307347, 4598.908021839545, 4599.0342028174455, 4612.123696497655, 4626.884327891829, 4656.557627025427, 4855.611551075976, 4864.82973095947, 4881.755912204376, 4886.315915771724, 4920.581750551171, 5027.2207807789855, 5146.0479811233545, 5183.403908550565, 5193.584513238856, 5199.324087868704, 4939.333190019302, 4942.481039490802, 4961.950380496149, 4962.627802914723, 4989.451160372429, 4866.197077482176, 5110.514501122388, 5113.360829896263, 5116.130257856248, 5125.564327032244, 5122.410922743932, 5148.613853960893, 5178.223266510054, 5184.585233181412, 5204.0, 5002.0, 5035.697858128524, 5036.8992620146655, 5043.798248070036, 5073.188289873602, 4866.756662166807, 4980.128477516348, 5014.122528557415, 5031.195008798574, 5045.596352291881, 4949.604031677385, 4954.603631709527, 4994.9500504994485, 5013.924791128063, 5054.848354549369, 4982.352294201731, 5021.698698078127, 5024.045431368028, 5065.7720402581235, 5073.416557095834, 4759.833405830779, 4934.7285899275885, 4953.801847926186, 4957.652964292465, 5003.44962054181], "value": 4688.317046631694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3646043510396, 597.674267524199, 600.0219641983566, 611.7797592866568, 627.6108812536228, 36413.81793091034, 40825.97935051625, 40836.0, 40890.59109408905, 41000.58999410005, 41839.0, 42309.57690423095, 42320.78839605805, 42460.787696061554, 42475.362869556906, 7920.16838231986, 8002.759917202493, 8095.757127286191, 8096.716614918479, 8097.838043239161, 7900.32847207988, 7910.960445197795, 7946.324562412202, 7989.800254993643, 7999.080105787822, 7974.681012759483, 7980.3615710743, 8012.879806802903, 8021.19788021199, 8022.19778022199, 7904.09102953162, 7975.0, 7990.680372785082, 8003.95998020012, 8014.639341229658, 7983.3214176795045, 7992.360611151152, 8046.8792968104935, 8062.032556093248, 8063.1130575636635, 30423.23941901448, 38109.428358574645, 38197.23605527902, 38288.80855595732, 38331.61668383308, 3096.6438859531218, 3101.5967924169713, 3116.67274936133, 3153.8896138635037, 3251.430999575065, 28905.0, 28952.71047289521, 29049.273768155756, 29115.272118197, 30240.0, 3366.5286859839644, 3388.4268659545896, 3408.5739282589675, 3494.0391392367046, 3504.0188747150837, 251272.0, 251625.0, 252246.0, 252880.7355963227, 253724.0, 34303.65696343055, 34306.313873722385, 34318.0, 34361.0, 34599.30801383958, 34698.826505867306, 36480.27039459196, 36648.0, 36682.63317366792, 36694.26611467756, 14161.575152745434, 14367.78448323276, 14403.135811851322, 14440.85559144416, 14453.349599267847, 11629.0, 11736.58921937745, 11776.0, 11800.350980696145, 11804.822927656092, 8399.160083991552, 8458.196471335214, 8459.619317130744, 8521.786955326166, 8545.957270213608, 3356.8992930212135, 3360.327934413127, 3379.087646335525, 3394.304167645676, 3396.7961922284744, 932.978388664425, 938.2447130060367, 956.784723437221, 981.7300242433245, 1014.1785154025263, 28448.288792780346, 29120.0, 29337.853310733735, 29428.558571621445, 29651.703482964895, 984.178211193647, 1014.2190513304714, 1021.9897801022043, 1028.2647906746713, 1047.209356935524, 15361.846381536265, 15724.764128538081, 15845.445409410615, 15920.601984950237, 16079.67840643204, 407377.0, 409410.0, 410232.0, 410914.0, 411545.0, 52167.217491737654, 52472.21291680628, 52526.47473525292, 52807.735961320715, 52895.0, 1256.8491780986158, 1278.3288773394042, 1297.6561211279018, 1308.3981368570564, 1310.3186343101534, 28435.715642844134, 28886.277843054093, 29050.12890003566, 29329.706702933552, 29723.702762972094, 43042.56957430511, 43556.34665479957, 43873.78063109664, 43897.34153987629, 44012.779936100116, 329190.0, 334431.0, 336193.0, 336217.0, 336654.0, 26334.341641459116, 26559.33601659974, 26690.7330926696, 26732.732672673803, 26890.731092688824, 42040.1591968165, 42762.57237427586, 43018.56981430146, 43268.78365608278, 43344.78327608342, 35727.0, 36880.07799805026, 37123.44314835333, 37182.44226336553, 37539.24921501609, 36389.45415818818, 36410.45384319184, 36776.816115919246, 37047.81476092602, 37295.0, 36269.63730362662, 38233.617663824116, 38883.0, 39083.80458097691, 41627.0, 31198.532022019233, 34619.48070778991, 34807.30385392329, 35007.12482187965, 35328.29343413169, 26212.606810898233, 26777.33056673599, 26888.865555672095, 26891.731082689705, 27165.0], "value": 16937.288861866564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.69218087258866, 379.73608342202164, 384.724921680998, 393.462923109955, 400.69346949583576, 16137.273822677978, 17398.13009349532, 17507.562310942234, 18140.546486337847, 18189.18148683309, 16493.17534123292, 17091.57271068221, 17852.732209016875, 18135.183916723745, 18158.81841181588, 5205.063088644042, 5357.035733567956, 5382.058139825534, 5404.83785486436, 5413.864653383657, 3726.906827329325, 5766.365699773021, 6137.324894261627, 6139.570230083896, 6242.563020588561, 6016.578839481238, 6039.765286843874, 6188.381161883821, 6194.039923811816, 6195.349488303731, 6154.138420621117, 6160.229971253593, 6196.721147548348, 6203.503719702413, 6206.441420272175, 4682.531746825291, 4974.701517908901, 5006.098902197603, 5358.624896257264, 5395.622306438551, 12987.480500779957, 13057.608271751862, 13553.119047261896, 20656.380308590768, 21086.683699744517, 1878.3238034307637, 1921.9135138918782, 1924.6535623587888, 2025.706272590481, 2045.5397535554382, 8884.422512536728, 9230.123138301851, 9634.0, 9775.755606109833, 11289.548418063268, 1673.4644913627521, 1697.125980120239, 1733.4452975047864, 1743.7210046392515, 1766.3199668127734, 69427.65286173587, 71001.0, 73073.63463182704, 73394.0, 75761.0, 9828.557714902703, 10050.145737612238, 10176.13502852251, 10408.907064758243, 10426.5829366826, 14336.139831610137, 14339.856601434061, 14379.352929118215, 14381.64045898861, 14432.917531185203, 7278.235785242579, 7381.520201186906, 7399.8150046249275, 7481.765508691005, 7577.128630207597, 7046.5067445279365, 7118.074650295532, 7186.353228209487, 7230.855382892312, 7253.818654533573, 4461.397711308997, 4492.146492166478, 4537.863864084083, 4601.5168407317415, 4618.815247390134, 1725.9654806904043, 1797.6135130946648, 1911.6845720456247, 1914.7606549181353, 1925.5956249187827, 893.9374243803002, 916.408916249029, 934.5887809363858, 975.6000039983714, 1032.2722480651123, 16926.153692315336, 16969.575760605836, 16991.575210619834, 17042.829571704373, 17176.39882604103, 902.670525258276, 927.1933417926447, 934.1219253901311, 1012.3022145981025, 1025.6769117727893, 9558.474283914451, 9603.327767056378, 9642.903570964341, 9656.27577931658, 9785.26610504215, 411054.0, 435439.0, 436713.0, 441942.0, 449485.0, 86680.0, 89047.0, 89809.0, 90407.54796225976, 90638.54680726553, 965.2953344058736, 969.9224062074876, 970.7767213540925, 970.8786401699788, 972.2999440402899, 15628.92185539065, 15817.209139543207, 15834.786562667245, 15929.20353982273, 15943.0, 36958.0, 37247.6963306283, 38327.616723832405, 38742.80628596952, 39135.6086439132, 52606.0, 55010.0, 55095.21500242577, 55266.44733552613, 55443.72278138583, 7565.130010048915, 7721.7683469496005, 7936.84126317482, 7964.960175199087, 8060.31487323584, 11025.117990560897, 11193.328400296008, 11664.766704666028, 12047.638570842888, 12583.496660133493, 5882.794102206402, 6947.826304342229, 10160.695179144637, 10232.181425485795, 10624.415657138932, 10265.948670256601, 10389.168866490814, 10398.27212095146, 10616.097631701392, 10728.302660327054, 4825.203841366276, 5993.61041532299, 10360.637377691744, 10565.418901960466, 10601.144799660184, 7609.733659322119, 7665.0, 7690.807729806799, 7713.267239612228, 7744.070711514654, 9715.562799674173, 10470.319429237075, 10471.424071675827, 10714.785704286027, 10726.410047447465], "value": 8399.576204777712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.9849701502985, 1527.9923600381999, 1729.4206440842318, 1881.7835948865868, 1891.3852997775718, 6794.96602516988, 7829.491083079603, 7846.72536461224, 8357.038940521841, 8359.4566353187, 7932.087809901863, 8109.4323397362205, 8156.265936065753, 8239.258466737992, 8255.133211012831, 2306.3542208181693, 2342.402687314741, 2347.307544274435, 2350.647402889572, 2353.082297903819, 2282.5092605089903, 2312.5490529346785, 2337.91817286395, 2351.412146963259, 2356.06935260572, 2219.711437513121, 2229.57638048771, 2244.3267019894047, 2345.061975209921, 2348.4833336665906, 2207.9448013799624, 2244.9448759083284, 2245.1692873636694, 2245.236619549353, 2248.4828489447355, 2219.8002179803893, 2238.8432809703327, 2240.0703707961175, 2244.3827947314458, 2258.232201051634, 8130.30892374143, 8224.218699223564, 8225.300849427806, 8226.794330141734, 8232.62953167109, 4679.555442232982, 4745.905081898377, 4763.49983251757, 4767.213409787381, 4789.928151077736, 2906.084583356257, 2907.563865420204, 3100.58142150809, 3109.347037122207, 3127.6090488688915, 922.0733163171037, 955.7467271173144, 960.0639376607821, 978.2467500024941, 979.2557656181282, 10375.533101010396, 10417.843732344021, 10449.895501044968, 10548.525316360781, 10558.947205264001, 4299.419578356944, 4322.481302243688, 4411.360352748898, 4449.0, 4518.209313370147, 9117.81764364709, 9122.589483473259, 9122.954385228164, 9142.451452912846, 9144.451332920045, 4870.878228044327, 4894.363732714724, 4896.755162241873, 4899.8285060023445, 4903.141950158708, 3808.200277941608, 4260.595243451867, 4363.38912552243, 4475.865724028285, 4479.395281636937, 3785.564660064128, 3817.9618203818163, 3903.6291552303055, 3944.073142811437, 3948.486696729407, 1270.1870802686287, 1270.4727538071782, 1277.3613193403298, 1277.6294874486296, 1291.231717128307, 652.3704625036862, 764.9885251721229, 796.1680044353549, 803.7146812881343, 878.2052242720348, 5050.141475949097, 5148.6910785353, 5159.871003224949, 5163.715995620277, 5398.676079435247, 878.8813510176172, 925.5788616179622, 926.5969303353063, 937.7749340158313, 939.1359948847077, 3392.643772403862, 3399.8300084995653, 3406.080358303294, 3499.68502834741, 3504.053905445566, 9564.904350956402, 9789.608415663293, 9843.458609776531, 9887.159591434809, 9897.703068907944, 9739.65911193119, 9865.605375785031, 9887.703368898945, 9915.652952146784, 9924.1068303853, 7116.857662846817, 7242.674079666428, 7328.157261914841, 7364.631768411558, 7423.072115985394, 5448.318960129984, 5493.285872836505, 5520.779168833202, 5563.666180029211, 5717.256756621613, 8792.208701216921, 8894.644214231617, 8943.150400711922, 8961.50711710836, 9062.365634405529, 8868.423552469068, 9070.682526111554, 9148.359614826899, 9169.862452063358, 9228.169464748205, 6274.309825919237, 6827.965860170866, 7023.859522809617, 7047.47143964215, 7230.276972302728, 7830.804229894298, 7896.368290536629, 7929.603519824101, 7957.562334071682, 7995.640196191302, 7045.260247674126, 7173.641317933978, 7179.246179151322, 7241.927580724126, 7299.233580474186, 7087.7164913402885, 7089.220185779457, 7146.499745017799, 7201.81995450097, 7230.927690723025, 6385.233771947396, 6618.139641846529, 6622.933770662425, 6768.1878174617395, 6784.219814721173, 4583.679142459996, 4662.93005604923, 4688.0, 4693.5071817458675, 4718.292256161603, 4720.12677654635, 4726.0, 4744.312074749211, 4757.286407038833, 4803.639727020557], "value": 4285.214756978578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5047676102041, 319.85766333981377, 325.0670575448463, 326.3456769177798, 326.9803811771295, 5070.163423035199, 5071.898562028762, 5084.593232541397, 5136.871578210537, 5154.355705536808, 5018.623603229754, 5028.220625802997, 5043.546080852722, 5060.215666571678, 5105.6936583805, 3784.3566593679143, 3859.9614003860024, 3926.509186351706, 3949.9802500987453, 3972.7616343019513, 3936.2914675358425, 3938.448617193595, 3965.702572307074, 3976.741511801738, 3983.223271462066, 3958.307296223164, 3963.1479231965122, 3976.7216294859372, 3985.8804235872826, 3998.140864498008, 3785.886423407302, 3941.625545573166, 3962.8414863405287, 3983.7410568312966, 3994.6604538614106, 3504.2115524006895, 3526.418141006731, 3536.1159710072484, 3537.5047493350953, 3538.292341531704, 4776.140294746944, 4799.0, 4818.566329030404, 4852.490488498727, 4902.28916807061, 4418.801153948048, 4521.231390663595, 4526.637868970474, 4536.319552067183, 4538.863834084983, 5182.305201295306, 5203.661761985459, 5211.661242019257, 5214.191800270926, 5230.320058392423, 3796.8101594920417, 3804.6766024887916, 3810.1046254130256, 3855.768653880748, 3857.1707082977014, 5383.273258110184, 5523.2543606613, 5539.639923404966, 5546.251256080418, 5566.359868615121, 3887.8639247626197, 3929.8975048349566, 3931.0958479549863, 3937.625925537069, 3956.8039737945714, 3974.5429275633096, 3978.9403158952637, 4012.776103288525, 4017.1764788218347, 4018.819153138116, 4450.666200034945, 4511.571400716926, 4518.141553104965, 4531.43357080365, 4569.063342014879, 5088.160453525201, 5193.974030129825, 5209.713465759344, 5247.63266571344, 5270.736463176826, 1361.9250941198131, 1364.9830875997247, 1367.6444124527695, 1370.9383077761524, 1384.8268966379203, 880.6345366672887, 898.5776684958059, 899.2086963472103, 906.664534122379, 907.5598334807613, 4595.471520775087, 4655.441347038377, 4657.254839225708, 4692.788824502905, 4702.27114797207, 5329.973350133225, 5331.226972089025, 5401.756920938567, 5413.756380962787, 5469.2616496772425, 4500.684952053325, 4667.533246675305, 4673.813047478131, 4690.64820138491, 4754.5245475452175, 2890.4941635213754, 2916.4251304295867, 2922.7286130533284, 2933.7066293370917, 2939.9265018374713, 5140.6634275088745, 5154.252633368141, 5164.54684025085, 5189.922151167735, 5190.6107041972, 5365.1907145926825, 5570.498655120978, 5572.721363931787, 5577.944220557823, 5598.384177740445, 5147.150720131286, 5162.74186290684, 5163.3545806774155, 5163.896722065613, 5175.0, 5448.618596698193, 5451.536619387396, 5464.398916119144, 5489.698066606375, 5492.862678433071, 5098.592112630907, 5345.492178243061, 5385.703786291635, 5398.568114550748, 5415.564875308125, 5161.66449180802, 5164.122099243213, 5190.792368305226, 5191.402988656353, 5213.973930130325, 3817.541894972621, 3857.2285542890972, 3882.359410697203, 3891.7859517726797, 3920.411938209177, 5211.661242019257, 5462.8907421850545, 5466.289382380424, 5471.151971444432, 5592.832215033555, 5240.34495688039, 5286.97356513215, 5287.52412282881, 5294.391145018372, 5307.495787900143, 5123.769430375568, 5266.815661451831, 5267.86740850719, 5279.736013199248, 5313.203019547099, 5170.27616133734, 5212.192110222922, 5215.461438875465, 5221.973890130677, 5223.921641175461, 5124.9743751281, 5147.2536482209125, 5354.919676204782, 5376.193570964387, 5377.596680249075, 5208.427073021889, 5209.921851172311, 5227.555657769132, 5248.317718696698, 5248.895022099613], "value": 4005.5593983429585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.3994324653783, 737.9889301660476, 782.5070205770365, 801.6913488307003, 821.2690705272305, 11214.0, 12017.519299228032, 12896.548620798285, 13300.268485233308, 13321.467141314335, 15028.624284392869, 15049.24753762313, 15089.320980555874, 15158.317875695593, 15170.089794612331, 688.0711040095881, 879.1428357351595, 894.5661354243219, 897.4615230861464, 898.5237823953315, 858.5578427110012, 885.3935054487664, 886.8448021596228, 888.9377743557953, 889.9555022248861, 932.2635118256569, 933.4772527384653, 937.69524904406, 938.061938061938, 940.3464592108487, 916.7845556294266, 921.6866265469705, 922.3543519536317, 923.7967647117623, 925.745420009496, 677.6408503493157, 684.0696652552524, 684.650828077679, 684.7192651013111, 684.7637565040053, 13458.327083645778, 13512.594622161252, 13535.052546321762, 13537.1200871944, 13548.187108773505, 12389.690257743538, 12604.55884044054, 12605.243685378815, 12651.683707907376, 12777.0, 10088.697339079767, 10294.691159265234, 10478.10936070435, 10530.15758739299, 10594.152467802558, 3286.6877646623534, 3310.304835984422, 3320.568326117613, 3348.866045358207, 3377.358301922651, 51529.0, 51830.0, 51906.74046629781, 52421.0, 53363.999999999614, 9974.353089105627, 10026.19790416765, 10079.5464204111, 10105.545250463747, 10359.223058270509, 18145.274189032556, 18149.092545372943, 18175.363862264756, 18186.45440636783, 18201.817981820277, 6541.6402097885075, 6618.106555614931, 6650.833729156713, 6728.6635668216395, 6828.5220034597105, 3752.2120354725266, 3766.0, 3817.7136714746507, 3832.5400951885954, 3862.8841134766003, 2786.400923801352, 2872.856357182174, 2873.913782586526, 2886.0620298403105, 2934.5598160275704, 579.2209478251744, 580.0255570641278, 589.5313225985352, 597.2206270816539, 605.0138274612442, 515.2245869965677, 565.7284503438373, 577.4110407384528, 598.7515181199753, 603.0270765127874, 8538.53038082899, 8767.736967890845, 8834.0, 8928.955355223183, 8963.865542016874, 498.3869840096629, 510.26474318325995, 599.409581562161, 613.7882430561449, 620.5221979076086, 4005.5193376794386, 4042.4542686737504, 4090.8568200112854, 4171.666266698718, 4532.886677833015, 49860.25209621859, 51570.484295156566, 51778.0, 58190.4180958185, 61613.69193154005, 51282.23076653779, 52170.0, 53049.0, 53787.462125379025, 54175.18737218945, 49967.503574606766, 50016.99966000659, 50427.24359134616, 50777.74611126921, 51141.74429127831, 8732.91267087321, 8855.0, 8865.157810008039, 8866.866996995179, 8978.506182160045, 32347.0, 32578.185545361557, 32686.83656581702, 33051.17372065622, 33067.33865322632, 37996.62003379931, 40675.0, 41174.79412603038, 41379.58620413878, 41869.0, 11800.0, 11898.22661526998, 11972.102092343282, 12032.75934481288, 12276.631701048982, 11893.881061189277, 12035.819462707892, 12064.698382540506, 12200.633980980585, 12257.38713064361, 11797.646070617895, 11924.70188245266, 12193.939030304791, 12300.753984920073, 12507.187032842836, 11398.430078496207, 11416.885831141582, 11596.652100437, 11655.417229138679, 11729.178957472895, 11074.280171788809, 11425.31448113116, 11640.0, 11736.675868586566, 11966.282023078295, 9482.336236463381, 9703.708888733348, 9846.60613575449, 9915.950420247853, 10179.98200179976, 9718.465484398426, 9828.239065811042, 9871.605135794487, 9927.156191723785, 10002.499875006366], "value": 6339.720161545101, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 119.0, 106.0, 114.0, 115.0, 115.0, 108.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 161.0, 214.0, 133.0, 155.0, 157.0, 140.0, 188.0, 132.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 171.0, 162.0, 163.0, 163.0, 164.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 168.0, 78.0, 75.0, 76.0, 76.0, 160.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 179.0, 94.0, 93.0, 92.0, 142.0, 92.0, 92.0, 138.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 68.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 83.0, 82.0, 83.0, 84.0, 83.0, 88.0, 150.0, 87.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 130.0, 129.0, 134.0, 142.0, 130.0, 132.0, 152.0, 134.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 173.0, 168.0, 168.0, 168.0, 170.0, 174.0, 172.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 69.0, 66.0, 67.0, 68.0, 68.0, 69.0, 67.0], "value": 67.3, "unit": "score"}]}]} 22:07:08 INFO - Return code: 0 22:07:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:07:08 ERROR - # TBPL SUCCESS # 22:07:08 INFO - Running post-action listener: _resource_record_post_action 22:07:08 INFO - ##### 22:07:08 INFO - ##### Finished run-tests step (success) 22:07:08 INFO - ##### 22:07:08 INFO - Running post-run listener: _resource_record_post_run 22:07:08 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546754560; Read time: 16; Write time: 512924 22:07:08 INFO - TinderboxPrint: CPU usage
13.4% 22:07:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:07:08 INFO - TinderboxPrint: I/O write bytes / time
546,754,560 / 512,924 22:07:08 INFO - TinderboxPrint: CPU idle
8,276.0 (86.6%) 22:07:08 INFO - TinderboxPrint: CPU user
1,228.4 (12.8%) 22:07:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:07:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251473920; Read time: 0; Write time: 275216 22:07:08 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295280640; Read time: 16; Write time: 237708 22:07:08 INFO - Running post-run listener: _upload_blobber_files 22:07:08 INFO - Blob upload gear active. 22:07:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:08 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 22:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:07:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:10 INFO - (blobuploader) - INFO - Done attempting. 22:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:10 INFO - (blobuploader) - INFO - Done attempting. 22:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:15 INFO - (blobuploader) - INFO - Done attempting. 22:07:15 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:15 INFO - Return code: 0 22:07:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0084cc4c79e8cf39df1081fd15dea6c2eb4399a973e209221d71492aade222c5b0ab659f925e7e3d7ca932334b5aba8f2c5679df8a701f62c42ef733f01d3e7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76d28358a67a248b494961895e7a08fbe42c77e95361301ae4caa3acee7317334530631b97f4a631fbdfa49009d6dd1eeb341ab000b2e30cabf77f3c35d53932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1d7fb8b047c766cdcdbe65fdd6d5ccebd388087ad584c099e739e525973fdaca85daaea4debbacb6949be499c0df645c62ac67dae090e4ddb3a62083ea7ac57"} 22:07:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:15 INFO - Contents: 22:07:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0084cc4c79e8cf39df1081fd15dea6c2eb4399a973e209221d71492aade222c5b0ab659f925e7e3d7ca932334b5aba8f2c5679df8a701f62c42ef733f01d3e7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76d28358a67a248b494961895e7a08fbe42c77e95361301ae4caa3acee7317334530631b97f4a631fbdfa49009d6dd1eeb341ab000b2e30cabf77f3c35d53932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1d7fb8b047c766cdcdbe65fdd6d5ccebd388087ad584c099e739e525973fdaca85daaea4debbacb6949be499c0df645c62ac67dae090e4ddb3a62083ea7ac57"} 22:07:15 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:15 INFO - Copying logs to upload dir... 22:07:15 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.917010 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-15 22:07:15.682674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 22:07:15.685866) ========= 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=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0084cc4c79e8cf39df1081fd15dea6c2eb4399a973e209221d71492aade222c5b0ab659f925e7e3d7ca932334b5aba8f2c5679df8a701f62c42ef733f01d3e7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76d28358a67a248b494961895e7a08fbe42c77e95361301ae4caa3acee7317334530631b97f4a631fbdfa49009d6dd1eeb341ab000b2e30cabf77f3c35d53932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1d7fb8b047c766cdcdbe65fdd6d5ccebd388087ad584c099e739e525973fdaca85daaea4debbacb6949be499c0df645c62ac67dae090e4ddb3a62083ea7ac57"} build_url:https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/SCs880ZaSqitwvq6IEVjaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0084cc4c79e8cf39df1081fd15dea6c2eb4399a973e209221d71492aade222c5b0ab659f925e7e3d7ca932334b5aba8f2c5679df8a701f62c42ef733f01d3e7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76d28358a67a248b494961895e7a08fbe42c77e95361301ae4caa3acee7317334530631b97f4a631fbdfa49009d6dd1eeb341ab000b2e30cabf77f3c35d53932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1d7fb8b047c766cdcdbe65fdd6d5ccebd388087ad584c099e739e525973fdaca85daaea4debbacb6949be499c0df645c62ac67dae090e4ddb3a62083ea7ac57"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 22:07:15.710503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 22:07:15.710828) ========= 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=00204705a9daa57ed339a427000001b9-1463369065.140134-783371218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 22:07:15.793632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 22:07:15.793973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 22:07:15.794298) ========= ========= Total master_lag: 0.18 =========