builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1463043214.27 results: success (0) buildid: 20160511232236 builduid: 90e0e96a7dd74771be300ea8dbc6a8e1 revision: 218969cdfaf0a78d9d5d0490b38532782ea902fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.269310) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.269889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.270383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.280756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.281107) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 01:53:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-05-12 01:53:35 (13.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.398826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.399142) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:34.446305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 01:53:34.446662) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 218969cdfaf0a78d9d5d0490b38532782ea902fe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 218969cdfaf0a78d9d5d0490b38532782ea902fe --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=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 01:53:35,725 truncating revision to first 12 chars 2016-05-12 01:53:35,725 Setting DEBUG logging. 2016-05-12 01:53:35,725 attempt 1/10 2016-05-12 01:53:35,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/218969cdfaf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 01:53:36,958 unpacking tar archive at: mozilla-inbound-218969cdfaf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499332 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 01:53:35.954919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:35.955234) ========= script_repo_revision: 218969cdfaf0a78d9d5d0490b38532782ea902fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:35.955757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:35.956072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 01:53:35.962220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-12 01:53:35.962565) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:53:37 INFO - MultiFileLogger online at 20160512 01:53:37 in /builds/slave/test 01:53:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:53:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:53:37 INFO - {'append_to_log': False, 01:53:37 INFO - 'base_work_dir': '/builds/slave/test', 01:53:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:53:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:53:37 INFO - 'branch': 'Mozilla-Inbound', 01:53:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:53:37 INFO - 'config_files': ('talos/linux_config.py',), 01:53:37 INFO - 'default_actions': ('clobber', 01:53:37 INFO - 'read-buildbot-config', 01:53:37 INFO - 'download-and-extract', 01:53:37 INFO - 'populate-webroot', 01:53:37 INFO - 'create-virtualenv', 01:53:37 INFO - 'install', 01:53:37 INFO - 'run-tests'), 01:53:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:53:37 INFO - 'download_minidump_stackwalk': True, 01:53:37 INFO - 'download_symbols': 'ondemand', 01:53:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:53:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:53:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:53:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:53:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:53:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:53:37 INFO - 'installer_path': 'installer.exe', 01:53:37 INFO - 'log_level': 'info', 01:53:37 INFO - 'log_name': 'talos', 01:53:37 INFO - 'log_to_console': True, 01:53:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:53:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:53:37 INFO - 'opt_config_files': (), 01:53:37 INFO - 'pip_index': False, 01:53:37 INFO - 'sps_profile': False, 01:53:37 INFO - 'sps_profile_interval': 0, 01:53:37 INFO - 'suite': 'dromaeojs-e10s', 01:53:37 INFO - 'system_bits': '32', 01:53:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:53:37 INFO - 'title': 'talos-linux64-ix-059', 01:53:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:53:37 INFO - 'use_talos_json': True, 01:53:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:53:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:53:37 INFO - 'work_dir': 'build'} 01:53:37 INFO - ##### 01:53:37 INFO - ##### Running clobber step. 01:53:37 INFO - ##### 01:53:37 INFO - Running pre-action listener: _resource_record_pre_action 01:53:37 INFO - Running main action method: clobber 01:53:37 INFO - rmtree: /builds/slave/test/build 01:53:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:53:37 INFO - Running post-action listener: _resource_record_post_action 01:53:37 INFO - ##### 01:53:37 INFO - ##### Finished clobber step (success) 01:53:37 INFO - ##### 01:53:37 INFO - ##### 01:53:37 INFO - ##### Running read-buildbot-config step. 01:53:37 INFO - ##### 01:53:37 INFO - Running pre-action listener: _resource_record_pre_action 01:53:37 INFO - Running main action method: read_buildbot_config 01:53:37 INFO - Using buildbot properties: 01:53:37 INFO - { 01:53:37 INFO - "project": "", 01:53:37 INFO - "product": "firefox", 01:53:37 INFO - "script_repo_revision": "production", 01:53:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:53:37 INFO - "repository": "", 01:53:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:53:37 INFO - "buildid": "20160511232236", 01:53:37 INFO - "pgo_build": "True", 01:53:37 INFO - "basedir": "/builds/slave/test", 01:53:37 INFO - "buildnumber": 652, 01:53:37 INFO - "slavename": "talos-linux64-ix-059", 01:53:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:53:37 INFO - "platform": "ubuntu64_hw", 01:53:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:53:37 INFO - "branch": "mozilla-inbound", 01:53:37 INFO - "repo_path": "integration/mozilla-inbound", 01:53:37 INFO - "revision": "218969cdfaf0a78d9d5d0490b38532782ea902fe", 01:53:37 INFO - "stage_platform": "linux64-pgo", 01:53:37 INFO - "builduid": "90e0e96a7dd74771be300ea8dbc6a8e1", 01:53:37 INFO - "slavebuilddir": "test" 01:53:37 INFO - } 01:53:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:53:37 INFO - Running post-action listener: _resource_record_post_action 01:53:37 INFO - ##### 01:53:37 INFO - ##### Finished read-buildbot-config step (success) 01:53:37 INFO - ##### 01:53:37 INFO - ##### 01:53:37 INFO - ##### Running download-and-extract step. 01:53:37 INFO - ##### 01:53:37 INFO - Running pre-action listener: _resource_record_pre_action 01:53:37 INFO - Running main action method: download_and_extract 01:53:37 INFO - mkdir: /builds/slave/test/build/tests 01:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:37 INFO - https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:38 INFO - Downloaded 1361 bytes. 01:53:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:53:38 INFO - Using the following test package requirements: 01:53:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:53:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'jsshell-linux-x86_64.zip'], 01:53:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:53:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:53:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53: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')]} 01:53:38 INFO - https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:39 INFO - Downloaded 23903079 bytes. 01:53:39 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'] 01:53:39 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 01:53:40 INFO - Return code: 0 01:53:40 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 01:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:40 INFO - https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:44 INFO - Downloaded 23903079 bytes. 01:53:44 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'] 01:53:44 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 01:53:46 INFO - Return code: 0 01:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:46 INFO - https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:47 INFO - Downloaded 10840239 bytes. 01:53:47 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'] 01:53:47 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 01:53:47 INFO - Return code: 0 01:53:47 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')]} 01:53:47 INFO - https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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 01:53:49 INFO - Downloaded 58367381 bytes. 01:53:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:53:49 INFO - mkdir: /builds/slave/test/properties 01:53:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:53:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:53:49 INFO - Contents: 01:53:49 INFO - build_url:https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:53:50 INFO - Running post-action listener: _resource_record_post_action 01:53:50 INFO - Running post-action listener: set_extra_try_arguments 01:53:50 INFO - ##### 01:53:50 INFO - ##### Finished download-and-extract step (success) 01:53:50 INFO - ##### 01:53:50 INFO - ##### 01:53:50 INFO - ##### Running populate-webroot step. 01:53:50 INFO - ##### 01:53:50 INFO - Running pre-action listener: _resource_record_pre_action 01:53:50 INFO - Running main action method: populate_webroot 01:53:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:53:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:53:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:53:50 INFO - '--tppagecycles', 01:53:50 INFO - '7'], 01:53:50 INFO - 'tests': ['tsvgm']}}, 01:53:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:53:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:53:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:53:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['damp', 'tps']}, 01:53:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'tests': ['damp', 'tps']}, 01:53:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['dromaeo_dom']}, 01:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:53:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['a11yr', 01:53:50 INFO - 'ts_paint', 01:53:50 INFO - 'tpaint', 01:53:50 INFO - 'sessionrestore', 01:53:50 INFO - 'sessionrestore_no_auto_restore', 01:53:50 INFO - 'tabpaint']}, 01:53:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['tsvgx', 01:53:50 INFO - 'tsvgr_opacity', 01:53:50 INFO - 'tart', 01:53:50 INFO - 'tscrollx', 01:53:50 INFO - 'cart']}, 01:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:53:50 INFO - 'tsvgr_opacity', 01:53:50 INFO - 'tart', 01:53:50 INFO - 'tscrollx', 01:53:50 INFO - 'cart']}, 01:53:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'talos_options': ['--disable-e10s'], 01:53:50 INFO - 'tests': ['tp5o']}, 01:53:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'tests': ['tp5o']}, 01:53:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'talos_options': ['--disable-e10s', 01:53:50 INFO - '--xperf_path', 01:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:50 INFO - 'tests': ['tp5n']}, 01:53:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:50 INFO - 'talos_options': ['--xperf_path', 01:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:50 INFO - 'tests': ['tp5n']}}, 01:53:50 INFO - 'talos.zip': {'path': '', 01:53:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:53:50 INFO - Running post-action listener: _resource_record_post_action 01:53:50 INFO - ##### 01:53:50 INFO - ##### Finished populate-webroot step (success) 01:53:50 INFO - ##### 01:53:50 INFO - ##### 01:53:50 INFO - ##### Running create-virtualenv step. 01:53:50 INFO - ##### 01:53:50 INFO - Running pre-action listener: _resource_record_pre_action 01:53:50 INFO - Running main action method: create_virtualenv 01:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:53:50 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 01:53:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:53:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:53:50 INFO - Using real prefix '/usr' 01:53:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:53:52 INFO - Installing pip.................done. 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:53:52 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 01:53:52 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 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:53 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 01:53:53 INFO - Cleaning up... 01:53:53 INFO - Return code: 0 01:53:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:53: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')]} 01:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:53: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', 'psutil>=0.7.1'] in /builds/slave/test/build 01:53: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 psutil>=0.7.1 01:53:53 INFO - Using env: {'DISPLAY': ':0', 01:53:53 INFO - 'HOME': '/home/cltbld', 01:53:53 INFO - 'LANG': 'en_US.UTF-8', 01:53:53 INFO - 'LANGUAGE': 'en_US:en', 01:53:53 INFO - 'LOGNAME': 'cltbld', 01:53:53 INFO - 'MAIL': '/var/mail/cltbld', 01:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:53 INFO - 'MOZ_NO_REMOTE': '1', 01:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:53 INFO - 'NO_EM_RESTART': '1', 01:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:53 INFO - 'PWD': '/builds/slave/test', 01:53:53 INFO - 'SHELL': '/bin/bash', 01:53:53 INFO - 'SHLVL': '1', 01:53:53 INFO - 'TERM': 'linux', 01:53:53 INFO - 'TMOUT': '86400', 01:53:53 INFO - 'USER': 'cltbld', 01:53:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:53 INFO - '_': '/tools/buildbot/bin/python'} 01:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:53 INFO - Downloading/unpacking psutil>=0.7.1 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:55 INFO - Installing collected packages: psutil 01:53:55 INFO - Running setup.py install for psutil 01:53:55 INFO - building 'psutil._psutil_linux' extension 01:53:55 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 01:53:55 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 01:53:55 INFO - building 'psutil._psutil_posix' extension 01:53:55 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 01:53:55 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 01:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:55 INFO - Successfully installed psutil 01:53:55 INFO - Cleaning up... 01:53:55 INFO - Return code: 0 01:53:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:53:55 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.0.0'] in /builds/slave/test/build 01:53:55 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.0.0 01:53:55 INFO - Using env: {'DISPLAY': ':0', 01:53:55 INFO - 'HOME': '/home/cltbld', 01:53:55 INFO - 'LANG': 'en_US.UTF-8', 01:53:55 INFO - 'LANGUAGE': 'en_US:en', 01:53:55 INFO - 'LOGNAME': 'cltbld', 01:53:55 INFO - 'MAIL': '/var/mail/cltbld', 01:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:55 INFO - 'MOZ_NO_REMOTE': '1', 01:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:55 INFO - 'NO_EM_RESTART': '1', 01:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:55 INFO - 'PWD': '/builds/slave/test', 01:53:55 INFO - 'SHELL': '/bin/bash', 01:53:55 INFO - 'SHLVL': '1', 01:53:55 INFO - 'TERM': 'linux', 01:53:55 INFO - 'TMOUT': '86400', 01:53:55 INFO - 'USER': 'cltbld', 01:53:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:55 INFO - '_': '/tools/buildbot/bin/python'} 01:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:53:57 INFO - Installing collected packages: mozsystemmonitor 01:53:57 INFO - Running setup.py install for mozsystemmonitor 01:53:57 INFO - Successfully installed mozsystemmonitor 01:53:57 INFO - Cleaning up... 01:53:57 INFO - Return code: 0 01:53:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:53: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')]} 01:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:53:57 INFO - Using env: {'DISPLAY': ':0', 01:53:57 INFO - 'HOME': '/home/cltbld', 01:53:57 INFO - 'LANG': 'en_US.UTF-8', 01:53:57 INFO - 'LANGUAGE': 'en_US:en', 01:53:57 INFO - 'LOGNAME': 'cltbld', 01:53:57 INFO - 'MAIL': '/var/mail/cltbld', 01:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:57 INFO - 'MOZ_NO_REMOTE': '1', 01:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:57 INFO - 'NO_EM_RESTART': '1', 01:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:57 INFO - 'PWD': '/builds/slave/test', 01:53:57 INFO - 'SHELL': '/bin/bash', 01:53:57 INFO - 'SHLVL': '1', 01:53:57 INFO - 'TERM': 'linux', 01:53:57 INFO - 'TMOUT': '86400', 01:53:57 INFO - 'USER': 'cltbld', 01:53:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:57 INFO - '_': '/tools/buildbot/bin/python'} 01:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:53:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:54:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:00 INFO - Downloading docopt-0.6.1.tar.gz 01:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:54:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:54:00 INFO - Running setup.py install for blobuploader 01:54:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:54:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:54:00 INFO - Running setup.py install for requests 01:54:00 INFO - Running setup.py install for docopt 01:54:01 INFO - Successfully installed blobuploader requests docopt 01:54:01 INFO - Cleaning up... 01:54:01 INFO - Return code: 0 01:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54:01 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')]} 01:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:01 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')]} 01:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:01 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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:54:01 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 01:54:01 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 01:54:01 INFO - Using env: {'DISPLAY': ':0', 01:54:01 INFO - 'HOME': '/home/cltbld', 01:54:01 INFO - 'LANG': 'en_US.UTF-8', 01:54:01 INFO - 'LANGUAGE': 'en_US:en', 01:54:01 INFO - 'LOGNAME': 'cltbld', 01:54:01 INFO - 'MAIL': '/var/mail/cltbld', 01:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:01 INFO - 'MOZ_NO_REMOTE': '1', 01:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:01 INFO - 'NO_EM_RESTART': '1', 01:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:01 INFO - 'PWD': '/builds/slave/test', 01:54:01 INFO - 'SHELL': '/bin/bash', 01:54:01 INFO - 'SHLVL': '1', 01:54:01 INFO - 'TERM': 'linux', 01:54:01 INFO - 'TMOUT': '86400', 01:54:01 INFO - 'USER': 'cltbld', 01:54:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:01 INFO - '_': '/tools/buildbot/bin/python'} 01:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:01 INFO - Running setup.py (path:/tmp/pip-uBpz0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:01 INFO - Running setup.py (path:/tmp/pip-DzY3wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:01 INFO - Running setup.py (path:/tmp/pip-oYxLw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:01 INFO - Running setup.py (path:/tmp/pip-D_DQCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:01 INFO - Running setup.py (path:/tmp/pip-jiQJfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:01 INFO - Running setup.py (path:/tmp/pip-4L0rc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:01 INFO - Running setup.py (path:/tmp/pip-cUfi5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:01 INFO - Running setup.py (path:/tmp/pip-EQ5Xzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:01 INFO - Running setup.py (path:/tmp/pip-lVTYl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:01 INFO - Running setup.py (path:/tmp/pip-oRznHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:01 INFO - Running setup.py (path:/tmp/pip-TFz_wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:01 INFO - Running setup.py (path:/tmp/pip-YYNllx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:01 INFO - Running setup.py (path:/tmp/pip-fTWUtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:02 INFO - Running setup.py (path:/tmp/pip-mvFr7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:02 INFO - Running setup.py (path:/tmp/pip-c091su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:02 INFO - Running setup.py (path:/tmp/pip-pavtJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:02 INFO - Running setup.py (path:/tmp/pip-lm86em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:54:02 INFO - Running setup.py install for manifestparser 01:54:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Running setup.py install for mozcrash 01:54:02 INFO - Running setup.py install for mozdebug 01:54:02 INFO - Running setup.py install for mozdevice 01:54:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Running setup.py install for mozfile 01:54:02 INFO - Running setup.py install for mozhttpd 01:54:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Running setup.py install for mozinfo 01:54:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Running setup.py install for mozInstall 01:54:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:54:02 INFO - Running setup.py install for mozleak 01:54:03 INFO - Running setup.py install for mozlog 01:54:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Running setup.py install for moznetwork 01:54:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Running setup.py install for mozprocess 01:54:03 INFO - Running setup.py install for mozprofile 01:54:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Running setup.py install for mozrunner 01:54:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Running setup.py install for mozscreenshot 01:54:03 INFO - Running setup.py install for moztest 01:54:03 INFO - Running setup.py install for mozversion 01:54:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:54:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:54:03 INFO - Cleaning up... 01:54:03 INFO - Return code: 0 01:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54:03 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')]} 01:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:03 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')]} 01:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:03 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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:54:03 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 01:54:03 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 01:54:03 INFO - Using env: {'DISPLAY': ':0', 01:54:03 INFO - 'HOME': '/home/cltbld', 01:54:03 INFO - 'LANG': 'en_US.UTF-8', 01:54:03 INFO - 'LANGUAGE': 'en_US:en', 01:54:03 INFO - 'LOGNAME': 'cltbld', 01:54:03 INFO - 'MAIL': '/var/mail/cltbld', 01:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:03 INFO - 'MOZ_NO_REMOTE': '1', 01:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:03 INFO - 'NO_EM_RESTART': '1', 01:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:03 INFO - 'PWD': '/builds/slave/test', 01:54:03 INFO - 'SHELL': '/bin/bash', 01:54:03 INFO - 'SHLVL': '1', 01:54:03 INFO - 'TERM': 'linux', 01:54:03 INFO - 'TMOUT': '86400', 01:54:03 INFO - 'USER': 'cltbld', 01:54:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:03 INFO - '_': '/tools/buildbot/bin/python'} 01:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:04 INFO - Running setup.py (path:/tmp/pip-BfeRt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:04 INFO - Running setup.py (path:/tmp/pip-imnl5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:04 INFO - Running setup.py (path:/tmp/pip-cahqJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:04 INFO - Running setup.py (path:/tmp/pip-suyv9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:04 INFO - Running setup.py (path:/tmp/pip-h2SNVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:04 INFO - Running setup.py (path:/tmp/pip-Dyz_xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:04 INFO - Running setup.py (path:/tmp/pip-xzZK4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:04 INFO - Running setup.py (path:/tmp/pip-WStTce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:04 INFO - Running setup.py (path:/tmp/pip-AfUhBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:04 INFO - Running setup.py (path:/tmp/pip-3kYzOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:04 INFO - Running setup.py (path:/tmp/pip-FGOICE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:04 INFO - Running setup.py (path:/tmp/pip-puOXBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:04 INFO - Running setup.py (path:/tmp/pip-8ZqHVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:04 INFO - Running setup.py (path:/tmp/pip-GQQi47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:04 INFO - Running setup.py (path:/tmp/pip-tiL6cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:04 INFO - Running setup.py (path:/tmp/pip-A4iUHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:05 INFO - Running setup.py (path:/tmp/pip-EQYM40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:06 INFO - Downloading blessings-1.6.tar.gz 01:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:54:06 INFO - Installing collected packages: blessings 01:54:06 INFO - Running setup.py install for blessings 01:54:07 INFO - Successfully installed blessings 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:54:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:07 INFO - Reading from file tmpfile_stdout 01:54:07 INFO - Current package versions: 01:54:07 INFO - argparse == 1.2.1 01:54:07 INFO - blessings == 1.6 01:54:07 INFO - blobuploader == 1.2.4 01:54:07 INFO - docopt == 0.6.1 01:54:07 INFO - manifestparser == 1.1 01:54:07 INFO - mozInstall == 1.12 01:54:07 INFO - mozcrash == 0.17 01:54:07 INFO - mozdebug == 0.1 01:54:07 INFO - mozdevice == 0.48 01:54:07 INFO - mozfile == 1.2 01:54:07 INFO - mozhttpd == 0.7 01:54:07 INFO - mozinfo == 0.9 01:54:07 INFO - mozleak == 0.1 01:54:07 INFO - mozlog == 3.2 01:54:07 INFO - moznetwork == 0.27 01:54:07 INFO - mozprocess == 0.22 01:54:07 INFO - mozprofile == 0.28 01:54:07 INFO - mozrunner == 6.11 01:54:07 INFO - mozscreenshot == 0.1 01:54:07 INFO - mozsystemmonitor == 0.0 01:54:07 INFO - moztest == 0.7 01:54:07 INFO - mozversion == 1.4 01:54:07 INFO - psutil == 3.1.1 01:54:07 INFO - requests == 1.2.3 01:54:07 INFO - wsgiref == 0.1.2 01:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:54:07 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 01:54:07 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 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 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)) 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:54: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')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:54: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', 'jsonschema'] in /builds/slave/test/build 01:54: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 jsonschema 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:07 INFO - Downloading/unpacking jsonschema 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:54:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:54:09 INFO - warning: no files found matching '*.txt' 01:54:09 INFO - no previously-included directories found matching 'build' 01:54:09 INFO - no previously-included directories found matching 'dist' 01:54:09 INFO - no previously-included directories found matching '.git*' 01:54:09 INFO - Installing collected packages: jsonschema, functools32 01:54:09 INFO - Running setup.py install for functools32 01:54:09 INFO - warning: no files found matching '*.txt' 01:54:09 INFO - no previously-included directories found matching 'build' 01:54:09 INFO - no previously-included directories found matching 'dist' 01:54:09 INFO - no previously-included directories found matching '.git*' 01:54:09 INFO - Successfully installed jsonschema functools32 01:54:09 INFO - Cleaning up... 01:54:09 INFO - Return code: 0 01:54:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:54:09 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')]} 01:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:09 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')]} 01:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:09 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 0x7f4a20333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', '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 01:54:09 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 01:54:09 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 01:54:09 INFO - Using env: {'DISPLAY': ':0', 01:54:09 INFO - 'HOME': '/home/cltbld', 01:54:09 INFO - 'LANG': 'en_US.UTF-8', 01:54:09 INFO - 'LANGUAGE': 'en_US:en', 01:54:09 INFO - 'LOGNAME': 'cltbld', 01:54:09 INFO - 'MAIL': '/var/mail/cltbld', 01:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:09 INFO - 'MOZ_NO_REMOTE': '1', 01:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:09 INFO - 'NO_EM_RESTART': '1', 01:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:09 INFO - 'PWD': '/builds/slave/test', 01:54:09 INFO - 'SHELL': '/bin/bash', 01:54:09 INFO - 'SHLVL': '1', 01:54:09 INFO - 'TERM': 'linux', 01:54:09 INFO - 'TMOUT': '86400', 01:54:09 INFO - 'USER': 'cltbld', 01:54:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:09 INFO - '_': '/tools/buildbot/bin/python'} 01:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:10 INFO - Downloading/unpacking flake8 01:54:10 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 01:54:10 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 01:54:10 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 01:54:10 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 01:54:10 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 01:54:10 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 01:54:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:12 INFO - no previously-included directories found matching 'docs/_build' 01:54:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:54:12 INFO - Running setup.py install for pep8 01:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:12 INFO - no previously-included directories found matching 'docs/_build' 01:54:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:54:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:54:12 INFO - Cleaning up... 01:54:12 INFO - Return code: 0 01:54:12 INFO - Running post-action listener: _resource_record_post_action 01:54:12 INFO - Running post-action listener: _start_resource_monitoring 01:54:12 INFO - Starting resource monitoring. 01:54:12 INFO - ##### 01:54:12 INFO - ##### Finished create-virtualenv step (success) 01:54:12 INFO - ##### 01:54:12 INFO - ##### 01:54:12 INFO - ##### Running install step. 01:54:12 INFO - ##### 01:54:12 INFO - Running pre-action listener: _resource_record_pre_action 01:54:12 INFO - Running main action method: install 01:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:54:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Output received: 01:54:13 INFO - Usage: mozinstall [options] installer 01:54:13 INFO - Options: 01:54:13 INFO - -h, --help show this help message and exit 01:54:13 INFO - -d DEST, --destination=DEST 01:54:13 INFO - Directory to install application into. [default: 01:54:13 INFO - "/builds/slave/test"] 01:54:13 INFO - --app=APP Application being installed. [default: firefox] 01:54:13 INFO - mkdir: /builds/slave/test/build/application 01:54:13 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'] 01:54:13 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 01:54:29 INFO - Reading from file tmpfile_stdout 01:54:29 INFO - Output received: 01:54:29 INFO - /builds/slave/test/build/application/firefox/firefox 01:54:29 INFO - Running post-action listener: _resource_record_post_action 01:54:29 INFO - ##### 01:54:29 INFO - ##### Finished install step (success) 01:54:29 INFO - ##### 01:54:29 INFO - ##### 01:54:29 INFO - ##### Running run-tests step. 01:54:29 INFO - ##### 01:54:29 INFO - Running pre-action listener: _resource_record_pre_action 01:54:29 INFO - Running main action method: run_tests 01:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:54:29 INFO - Python 2.7.3 01:54:29 INFO - Return code: 0 01:54:29 INFO - grabbing minidump binary from tooltool 01:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:29 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 0x14799c0>, '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 0x147a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:54:29 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 01:54:29 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 01:54:29 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 01:54:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:54:29 INFO - Return code: 0 01:54:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:54:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:54:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:54:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:54:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:54:30 INFO - Return code: 0 01:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 01:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 01:54:30 INFO - Using env: {'DISPLAY': ':0', 01:54:30 INFO - 'HOME': '/home/cltbld', 01:54:30 INFO - 'LANG': 'en_US.UTF-8', 01:54:30 INFO - 'LANGUAGE': 'en_US:en', 01:54:30 INFO - 'LOGNAME': 'cltbld', 01:54:30 INFO - 'MAIL': '/var/mail/cltbld', 01:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:30 INFO - 'MOZ_NO_REMOTE': '1', 01:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:30 INFO - 'NO_EM_RESTART': '1', 01:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:30 INFO - 'PWD': '/builds/slave/test', 01:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:54:30 INFO - 'SHELL': '/bin/bash', 01:54:30 INFO - 'SHLVL': '1', 01:54:30 INFO - 'TERM': 'linux', 01:54:30 INFO - 'TMOUT': '86400', 01:54:30 INFO - 'USER': 'cltbld', 01:54:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681', 01:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:30 INFO - '_': '/tools/buildbot/bin/python'} 01:54:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 01:54:30 INFO - mozversion application_buildid: 20160511232236 01:54:30 INFO - mozversion application_changeset: 218969cdfaf0a78d9d5d0490b38532782ea902fe 01:54:30 INFO - mozversion application_display_name: Nightly 01:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:54:30 INFO - mozversion application_name: Firefox 01:54:30 INFO - mozversion application_remotingname: firefox 01:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:54:30 INFO - mozversion application_vendor: Mozilla 01:54:30 INFO - mozversion application_version: 49.0a1 01:54:30 INFO - mozversion platform_buildid: 20160511232236 01:54:30 INFO - mozversion platform_changeset: 218969cdfaf0a78d9d5d0490b38532782ea902fe 01:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:54:30 INFO - mozversion platform_version: 49.0a1 01:54:30 INFO - using testdate: 1463043270 01:54:30 INFO - actual date: 1463043270 01:54:30 INFO - starting webserver on 'localhost:37255' 01:54:30 INFO - SUITE-START | Running 2 tests 01:54:30 INFO - TEST-START | dromaeo_css 01:54:30 INFO - operating with platform_type : linux_ 01:54:30 INFO - Initialising browser for dromaeo_css test... 01:54:30 INFO - TEST-INFO | started process 19357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH6Ureq/profile http://localhost:37255/getInfo.html) 01:54:34 INFO - PROCESS | 19357 | 01:54:34 INFO - PROCESS | 19357 | (process:19424): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:54:34 INFO - PROCESS | 19357 | __metrics Screen width/height:1600/1200 01:54:34 INFO - PROCESS | 19357 | colorDepth:24 01:54:34 INFO - PROCESS | 19357 | Browser inner width/height: 1024/697 01:54:34 INFO - PROCESS | 19357 | __metrics 01:54:35 ERROR - PROCESS | 19357 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:54:35 INFO - TEST-INFO | 19357: exit 0 01:54:35 INFO - Browser initialized. 01:54:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:54:35 INFO - TEST-INFO | started process 19475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH6Ureq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:37 INFO - PROCESS | 19475 | 01:54:37 INFO - PROCESS | 19475 | (process:19535): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:54:47 INFO - PROCESS | 19475 | RSS: Main: 162074624 01:54:47 INFO - PROCESS | 19475 | 01:55:36 INFO - PROCESS | 19475 | 1463043336997 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] 01:57:44 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37255/tests/dromaeo/cssquery-ext.html) 01:57:45 INFO - PROCESS | 19475 | RSS: Main: 164626432 01:57:45 INFO - PROCESS | 19475 | 02:00:47 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-ext.html (next: http://localhost:37255/tests/dromaeo/cssquery-jquery.html) 02:00:48 INFO - PROCESS | 19475 | RSS: Main: 165715968 02:00:48 INFO - PROCESS | 19475 | 02:03:50 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37255/tests/dromaeo/cssquery-mootools.html) 02:03:50 INFO - PROCESS | 19475 | RSS: Main: 166658048 02:03:50 INFO - PROCESS | 19475 | 02:06:52 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37255/tests/dromaeo/cssquery-prototype.html) 02:06:52 INFO - PROCESS | 19475 | RSS: Main: 164712448 02:06:52 INFO - PROCESS | 19475 | 02:09:55 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37255/tests/dromaeo/cssquery-yui.html) 02:09:55 INFO - PROCESS | 19475 | RSS: Main: 166088704 02:09:55 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | Cycle 1(1): loaded http://localhost:37255/tests/dromaeo/cssquery-yui.html (next: http://localhost:37255/tests/dromaeo/cssquery-dojo.html) 02:12:58 INFO - PROCESS | 19475 | RSS: Main: 167723008 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | __start_tp_report 02:12:58 INFO - PROCESS | 19475 | _x_x_mozilla_page_load 02:12:58 INFO - PROCESS | 19475 | _x_x_mozilla_page_load_details 02:12:58 INFO - PROCESS | 19475 | |i|pagename|runs| 02:12:58 INFO - PROCESS | 19475 | |0;dojo.html;3115.610548681415;3141.450246206913;3183.5383869338953;3189.5215717642336;3202.823844688541;5352.759125839337;5357.30355053843;5357.544608708265;5377.623566350357;5537.889242215163;5158.638895277332;5213.113770658988;5233.476652334764;5251.396089449714;5304.389995150559;4804.567588917005;4897.902041959159;4914.213725803872;4931.211006239003;4932.827351042714;4849.951500485003;4990.30135780991;5015.699058056528;5049.596032317424;5075.949240507584;4854.781534830923;4960.2559616057515;4964.180910149821;5009.4239162496415;5019.272205530214;4919.065377578248;4936.456989731127;4939.259111133323;4961.479044700291;4983.177775667011;4870.732109733964;4893.241547560134;4897.926531102036;4906.386701662293;4948;5063.670861393997;5199.168133098686;5268.604854635918;5291.708956007418;5304.761285742151;5688.800891968761;5694.601377903548;5741.081426971707;5766.62516936402;5785.652860828363;5759.107338362561;5802.245708057925;5833.504152147073;5856.355800861902;5886.7939622113445;5424.891502169935;5466.945330546683;5475.534579560782;5489.862753431196;5527.834164975017;5960.284765828128;5962.07587823888;5987.760489580455;5992.250968628921;6049.425304596057;5460.672359658433;5587.776488940478;5597.944020559824;5747.3103227612955;5756.597038207369;5746.597738158289;5754.079347304411;5761;5769.884602308014;5780.88438231233;5689.317281926195;5720.828375148669;5724.284464441945;5726.198332233491;5773.682447465346;5525.751341189656;5630.662160270397;5663.490285874291;5692.9146062809095;5770.336411312753;4297.548757380492;4315.6763242756915;4340.544242854455;4371.0820727646915;4402.163588918095;3921.137349783043;3952.3405952440417;3954.3277642800217;3978.980105099456;4002.799860006988;5039.899202015939;5319;5398.595105367113;5508.91736623951;5538.224648549206;5736.627119237236;5752.626079304831;5786.1610066540115;5821.854453638608;5831.620944638585;5457.454254574511;5527.060399732055;5530.446955304437;5547.583931205176;5569.415211402826;4817.349657796222;4932.309476673268;4943.752812359367;4955.82654607087;4960.330355402047;6023.367546407651;6026.186464827192;6056.697165141725;6064.363241859542;6066.696665166724;5805.854853628524;5827.446392592697;5828.737706803204;5833.649981001154;5838.532917366516;5775.768969241351;5895.322037965518;5907.054871220584;5918.171455996078;5928.199693041384;5619.775208991595;5638.5489160867855;5655.179998900054;5671.376148623565;5717.799877004285;5624.29696287964;5715.971125197504;5728.713564321851;5767.106098554731;5780.971095144498;5541;5584.748686309207;5601.887962240814;5602.411746766694;5633.014222511126;5593.272874526286;5603.299587551556;5606.747696353756;5619.9719001406365;5657.745401457027;5389.487998640123;5415.620906536505;5503.839367808983;5509.421510741475;5565.081761509306;5548.833534993957;5601.187827765033;5608.158776183442;5677.489025987681;5758.452946970031;5564.860878478071;5572;5576.972115139399;5582.33012038558;5589.972050139723 02:12:58 INFO - PROCESS | 19475 | |1;ext.html;563.5829486180228;598.8532809461681;604.9987271066382;621.3289647181043;669.2069897171849;37250.25499490012;41737;41938.16123677528;42045.159096818046;42238.57761422385;42006.57993420072;42606.78696606521;42702.35946460805;42755.358669619905;42816.35775463363;8568.143185681429;8747.037825839152;8751.3436492263;8807.515586642732;8820.514871682055;8544.444611100289;8641.092685268051;8659.220670139686;8718.782030449258;8746.38775285727;8708.129187081273;8713.738587842376;8718.128187181263;8755.868661970075;8821.382503224777;8619.396642235015;8657.437266577652;8678.175573320525;8698.130186981283;8716.782080447976;8715.215630593213;8736.563171841446;8748.168923952278;8748.518831464267;8773.736787896374;33565.993020209185;37565.43651845225;37750.433743493595;37917.24165516674;38148.80925595382;3374.409478341305;3523.2248905241063;3587.515685382466;3625.2205775758075;3820.1595648957186;30260.092197234117;30287.545686814716;30633.540496892565;30663.2334191647;31048.379032419452;4034.334334834749;4150.543440221573;4163.39630753539;4170.624643782044;4190.979045104786;256749;262433;262483;262968;263681;34383.65616343854;34669.1332716679;34960.30079398398;34964.300713986086;35015.64984350124;35541.64458355383;37334.813325933195;37577.43633845494;37705.81147094247;37931;15723.921380393025;15874;15930.203489825462;15964.680706385807;16016.679666406606;13378.063535552417;13491.460341586422;13520;13541.932290338485;13576.049676522745;8437.367197460215;8481.915180848237;8525.914740852637;8532.23209911111;8534.658613655385;3377.831108444568;3389.5932488101585;3403.897883063512;3405.3700065487965;3424.229548351601;1106.4799544214206;1207.3178654060428;1245.3959829482694;1245.682351000489;1256.4597223193932;31768.682313176574;32077.839610801795;32131.839340803148;32545.67454325474;32721.18197045093;1161.3380373187372;1199.2924174736947;1232.7904256276454;1235.8022716365338;1268.1693490763564;16561.83438165627;16831;17062.914685426742;17152.571185720455;17351.3059477622;457021;460237;466479;467630;470013;37244;37708.811455942545;37718;37802.81098594544;37885.62114378821;1424.1241636393543;1424.7364237616075;1448.4857875454063;1450.5068276785944;1451.2816156002634;30347;30372;30504.389912202074;31260.218494537818;31484.527732083578;48746;50336;50422.2436663443;50556.747216263684;50983.49016509787;315340;316844;318072;318189;318496;27703.584446233726;27841.721582783914;28157.71842281551;28394.290142746595;28444.004459843807;48112.518874810805;48210;48844;49060.75469622772;49410;39870.80064599775;40055.56219381054;40250.1949961005;40639;41308.38037429381;39977.20045599013;40978.59021409748;41000.58999410087;41187.794061030705;41413.378799318634;40713;40906;42227.57772422236;42334;45079.32381014353;33784.32431351408;35222;35896.64103358933;36412.27175456529;36422.81788591146;27450.862745686143;28085.859570702833;28097.71902280951;28381.716182837907;28387.574186387636 02:12:58 INFO - PROCESS | 19475 | |2;jquery.html;408.1734487662485;410.96301332880046;413.17983802152725;415.54705371145445;426.94022836802856;14897.77653335201;17280;18344.63310733788;19107.61784764304;19203.807961920378;18054.638907221848;18384;18401.631967360678;18463.538411539685;18699.158537865795;5587.888242235163;5690;5773.682447465388;5773.971130144343;5847.941520584804;5734.7419366128415;5738.110592858114;5776.422357764211;5800.651960882339;5818.389069147742;5511.889762204773;5665.3768085510565;5733.541316694655;5734;5749.913751293734;5483.095289277265;5676.574256930726;5709.486146246816;5719.370869204384;5741.511971482387;5129.794808207667;5142.588592912558;5145.922811157836;5168.069747445458;5194.740262986836;22156.556868862695;22603.095876164934;22843.42891427711;23035.308940731804;23108.0756769729;2012.7282816819688;2154.429076294783;2296.827737919646;2386.355683965337;2474.0598572542317;9244.953775231148;10274.7431314217;10309.123724483428;10317.484125793755;10524.684259472151;1941.3787587971854;1979.4061781465502;2001.4996250937265;2021.787712290203;2055.8972051397373;80342;81124.18875811226;81494;84741;85427.57286213654;11229.831552526719;11279.436028198557;11281.717957050976;11438.142139339583;11455.484503197376;13806.585802425943;14571.41714331415;16168.919155404148;16186.271617777229;16205.10871902033;7972.880406793903;8407.369447291356;8505.234528892306;8561.828763424697;8711.869321960176;8275.54484503358;8278.379121565908;8314.750557483285;8403.747887563382;8415.284700800501;4778.331033655221;4850.485746773316;4855.441624213261;4919.7540122993705;4930.309756634074;2026.7466566679166;2037.8777273363646;2043.83649308055;2058.423641380416;2081.5004398944448;932.137772560379;1015.2740790334946;1025.0620682075967;1054.4306074719718;1081.324172392255;17537;17690;18406.63186736258;19166.520836978907;19482.318118865773;995.8058178655093;997.2620261006948;1014;1017.6336518853207;1046.984295235572;10571.36571805694;10716.624918127984;10783.13734901206;10831.83752243717;10908.236423450282;349557.00885982136;355415;460876;465201;470547;91716;93189.5340523293;96446.51776741071;98231.50884245533;98340.50829745806;1029.994850025745;1096.276457538037;1098.4562641492512;1098.5441041967495;1099.4722533183956;16797.580060498585;17141.828581714024;17200.483985480456;17456.30174792994;17631.206595702966;40272.1945561093;40677.389839151845;40933.38599920944;41951.7902410486;42400.57599423966;56452.43547564636;56924.71537642451;59096;59128.704356477945;59957;8443.577821109044;8460.492370457792;8678.499021165775;8822.867656985021;8828.42615230008;12321.44553495077;12848.293343866177;13119.803202952155;13262.204267743966;13519.662008449868;11193.944030279796;11619.883801161881;11776;11821.881781182077;11965.581204657796;11142.220044596801;11258.831117533407;11440.256383335056;11477.48351324209;11521.769564608829;11575.76848463043;11928.940355298168;11966.162368634112;11981.820272696092;12209.145359824726;7374.410047196104;8037;8166.142555031874;8232.753017409488;8881.111888811067;11282.379469129277;12465.563705270271;12530;12542.1847579907;12556.811647825472 02:12:58 INFO - PROCESS | 19475 | |3;mootools.html;1474.1228968763583;1528.0984219310608;1669.4574263364402;1803.7294405839132;1812.3384964487966;7382.630868456569;8169.387295952798;8275.710350137746;8837;8851.07063758305;8147.226013528705;8375.078741338448;8469.66121355145;8487.40588158829;8516.489010659365;2270.5912935671613;2314.5486630107134;2315.6642286868396;2317.6755254264417;2331.62693968965;2105.3368189020484;2172.3482955113404;2265.954680906381;2278.8063014643776;2279.977200227993;2223.5997520446313;2224.8998795054263;2236.083205885587;2240.1039584166383;2246.629306164481;2166.360923527563;2175.6845257437662;2176.640854259061;2193.813525850305;2203.06369792839;2046.2531176120758;2048;2054.6301665700166;2067.865588736727;2068.6483297839254;8448.90164278646;8481.279091277249;8504.914950850474;8511.57442127891;8559.315254779603;5062.620303477254;5188.014277287303;5210.166373380279;5227.163653815372;5266.052110620087;3270.9182270443193;3275.8853440129483;3409.6760807723226;3428.125827913866;3428.468587368962;1034.932729372596;1048.2609760119099;1048.7430579507993;1066.193243806159;1107.855978722769;12007.519699212022;12117.636470905887;12156.270623762513;12172;12239.082068844873;4542.568455996675;4618.284165954283;4670;4717.386739723814;4756.9524304756505;10156.339837910513;10165.644202453026;10180.98190180976;10234.59061637541;10267.640632577824;5029.446760856303;5107;5112.284280200774;5124.359455068116;5126.974365128151;4115.8971025724595;4758.214894542361;4779.545943135397;4889.535494128052;4927.96512732323;3976.363781794899;4011.5988401159652;4025.81883815229;4106.905478206137;4198.748075115503;1276.9170003949714;1285.5307812648316;1300.8504022037587;1303.3548393545257;1318.940647670857;991.5191132300828;1014.4724743133529;1021.7190272675074;1029.9279050466396;1037.7509397744486;5880.235569375954;5888.705564721747;5905.350411454737;6102.328743838174;6171.722272497748;915.2997956563235;929.256594724218;982.5922242269521;1011.1102230037667;1015.7409860485677;3868.3423817951016;3881.320768865494;4017.779022153751;4067.491563554556;4131.793410329472;10490.423026733602;10854.45727713611;10863.402512861869;10876.129909607213;11122.666320010412;10801.459927003776;10903.945480272707;10904.78190436187;10939.343639381663;10956.671299861016;7964.761057168294;7990.4007199460275;8132.430729848854;8157.184281571914;8212;5683.119116536944;5716.085426331767;5817.825465236049;5853.180554722428;5859.970700146472;9663.613455461984;9782.41305521671;10060.949695251476;10066.597336106766;10197.439140847324;9952.353097048668;9986.60053597877;10278.383297002203;10322.638707645196;10392.740181495523;6561.081448597105;7133.536320139175;7346.265373462611;7445.590492522963;7455.291747283999;8495.980482342158;8551.74344769658;8552.401331906707;8593.31253499731;8611.440256383315;7575.621218939141;7739.806504837424;7785.260400261966;7814.296713295831;7954.403419743427;7532.359749421361;7666.310032097138;7707.383409327353;7716.8456630868195;7798.25916537928;6615.834604134935;6624.171978502687;6654.367835055662;6662.433693136138;6668.466522678077;5059.569936555286;5125.359330083739;5223;5231.869203269796;5275.815346463009;5141.974290128525;5243.55429788457;5326.97336513315;5333.253344531691;5359.758810853443 02:12:58 INFO - PROCESS | 19475 | |4;prototype.html;332.6407479921685;347.9843407046684;348;348.4077068982729;349.99999999999994;5472.753726082326;5500.257465242191;5522.889542209158;5577.410438025164;5580.944190558093;5328.760205790739;5350.170723537848;5386.8922621547545;5387.19192121182;5398.4601539846;4094.7306335036087;4253.1706317268145;4265.658747300224;4300.849680058743;4330.523642399334;4002.6197511236387;4177.916441671165;4216.430781844458;4242;4243.066525364415;4218.810153543098;4257.169851878885;4257.233697934371;4261.360795880627;4274.829006839723;4234.66122710184;4267.1252393259465;4273.380359847836;4281.587076264826;4285;3432.1248081738995;3615.4938308636547;3621.0042238384654;3785.6025117362556;3819.656230939229;5231.2937753403185;5248.895022099575;5261.789528418859;5308.469153084699;5326.493983071602;4725.849738369034;4757.643176761757;4768.5946694531;4774.665773395864;4775.06333604834;5351.304330437058;5663.207150998864;5677.432256774331;5713.828585142411;5757.41671040463;4030.3954406838916;4038.1318016626274;4043;4059.4925634295714;4074.694397920168;5669.773209071632;5813.593048486608;5936;5939.07944268639;5969.31352894414;4062.984253936516;4073.89815254621;4076.5719599442223;4106.774127422961;4118.855840045584;4134.772587507656;4143.109231515239;4160.9375859362135;4173.853915112956;4177.456930599003;4629.634257893929;4780.398566480268;4798.23228283473;4813.470518242991;4834.975825120922;5669;5677.091665333527;5692.743826527816;5731.799387021434;5740.196372507852;1411.6894283257666;1416.2918540729636;1423.8220222472191;1425.7026106243477;1428.357239242345;846.2975730143966;891.4873947480095;902.6479672927563;921.7188757428914;924.8797656304772;4785.473597904228;4863.708177509361;4864.100141473838;4870.512948705101;4879.682820616648;5085.2372144177925;5090.498303000623;5144.459831717691;5156.845294641167;5176.567013503647;4662;4842.709437433765;4851.878703032452;4888.560029597354;4903.376693468977;2701.2436517775054;2730.4266104118356;2733.72662733725;2759.323965628434;2776.4308316795414;5184.533391994663;5217.278298161597;5259.868503287448;5318.840434786963;5320.158655623364;4885.731284779371;5077.873053173626;5201.219817027476;5219.608529360313;5228.346456692913;5123.462036486116;5167.088177374396;5185.48145185486;5232.293640358503;5232.73836308183;5037.496250375079;5060.316857224375;5063.316452279042;5073.14830087023;5140.228965655182;4697.21505827797;4970.105381031449;4985.5791099536455;4992.5756310714;5006.274090256965;5684.516816070515;5868.94131058684;5999.160117583455;6017.585867321089;6030.698465076816;3939.5075615548058;3975.920481590294;4000.6999475038906;4015.2170326787164;4017.4777278953547;5680;5774.769009239583;5854.853628659318;5864.120381942743;5872.677002764889;5614.494695477427;5650.943490565041;5660.801871934463;5661.433856614471;5687.402822703722;5556;5577.932137324537;5598.972005139948;5605.645628835817;5615.522680572197;5285.392179899207;5490.862728431821;5515.124857548452;5536.667799932017;5556.249906262603;5655.802046928337;5677.460641239076;5683.801066962802;5723.255976723;5733.913991290051;5283.973580132075;5526.4078349073425;5586.664800112007;5610.438956104357;5655.349634791887 02:12:58 INFO - PROCESS | 19475 | |5;yui.html;752.9058867641545;766.9923300766991;769.6382700130937;826.516487854605;882.717530390275;13452.596422107341;14179.574612761608;14213.857861421395;14231.359588818503;14309.713805723892;12006.27962322259;12266.877331226686;12427.68930776731;12484;12627.684307892285;663.2505269045971;802.3060053054124;813.1137060603941;820.4502983001404;821.9314890642171;792.3581898662102;807.2855522862279;812.4353574265888;820.8071103290722;825.2613910550054;854.8803167556516;860.2859626510013;864.1358641358642;865.7705707987388;868.3530769576674;853.4580541356221;857.1685465098844;859.776458120893;861.6036623153326;863.4689665855485;619.1424876545972;626.4894111299277;626.8808926304033;627.5356236385088;628.1174949196386;12673.683157921034;12733.490660373574;12734.554290599785;12773.61679149627;12802.359882005863;13876.791848122186;14056.648583785385;14143.151410915276;14239;14248;10991.890081099247;11035.172362072877;11068.612598559012;11139.220254582182;11289;3741.28915506053;3761.680257178143;3799.8290076946328;3824.9043773905596;3847.2690188864026;52099;52398;52770.47229527694;52885.206721898816;53004.46995530034;10961.945190273998;11130;11136.171692582873;11298.096152307795;11435;19574.510637234183;19575.902120489307;19730.309439169847;19887.403377898685;20432.489187770127;7939.682412703427;8056.113827478973;8094.392920530984;8117.959410202911;8213.79465513367;4331.242032644274;4413.889652758642;4460.107978404268;4621.329907163443;4732.361131247238;3295.489199174132;3395.0324157615455;3400.795952242873;3404.5403870477166;3406.795592264472;605.2615808713363;634.4068296143121;640.3596403596404;643.2988043033023;648.9123968264319;718.6730037832774;722.9313215244543;741.1143683298407;744.9106107267163;753.8379248461607;8529.445586036887;8806.119388061143;8860.8670869937;9023.548822558845;9216.861747073799;716.7634680555404;743.5278598090143;747.5925620536821;753.148941695891;753.2091304130751;4154.91690166195;4243.978780106141;4280.4863416390235;4363.214621368184;4405.867823965286;62678.37321626816;63233.68383158055;63770.68114659397;64331.67834160893;64659.67670161619;57503.13745293824;57581;58001.4199857996;58513.70743146342;59847.700761495915;53181.2022819658;53333;53338.19992700113;53692;53734.46265537295;8296.087430382533;8353.24820766134;8522.872156917527;8743.650253989768;8766;33598.83200583982;34041;34301.828490857384;34351.48472772961;35262.823685881405;44758.77620611876;45024.77487612672;45042.77478612586;45149.54850451453;46288.30567541422;10503.684889453329;11571.727110017722;11698.35659038727;12104.334261615695;12150.724173961607;11922.701932451759;12776.74446511083;12825.294608796607;12954.222746635232;13075.150115242479;11943;12219.981468360049;12462.43919023628;12480.75038499243;12546.686332841751;12215.144939854124;12377.814332784836;12435.06736994711;12710.936445317715;13129.277889716157;11220.270682405617;11941.402929853299;12328.137030407785;12334.568290109803;12638.178518396275;10236.590536378759;10389.636362727268;10441.216908731723;10517.21120915919;10670.89329106699;10060.295779295378;10652.520636571218;10693.198010149114;10756.085732712494;10878.673639790819 02:12:58 INFO - PROCESS | 19475 | __end_tp_report 02:12:58 INFO - PROCESS | 19475 | __start_cc_report 02:12:58 INFO - PROCESS | 19475 | _x_x_mozilla_cycle_collect,297 02:12:58 INFO - PROCESS | 19475 | __end_cc_report 02:12:58 INFO - PROCESS | 19475 | __startTimestamp1463044378494__endTimestamp 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | ------- Summary: start ------- 02:12:58 INFO - PROCESS | 19475 | Number of tests: 6 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#0] dojo.html Cycles:165 Average:5347.87 Median:5564.86 stddev:602.31 (10.8%) stddev-sans-first:578.14 02:12:58 INFO - PROCESS | 19475 | Values: 3115.6 3141.5 3183.5 3189.5 3202.8 5352.8 5357.3 5357.5 5377.6 5537.9 5158.6 5213.1 5233.5 5251.4 5304.4 4804.6 4897.9 4914.2 4931.2 4932.8 4850.0 4990.3 5015.7 5049.6 5075.9 4854.8 4960.3 4964.2 5009.4 5019.3 4919.1 4936.5 4939.3 4961.5 4983.2 4870.7 4893.2 4897.9 4906.4 4948.0 5063.7 5199.2 5268.6 5291.7 5304.8 5688.8 5694.6 5741.1 5766.6 5785.7 5759.1 5802.2 5833.5 5856.4 5886.8 5424.9 5466.9 5475.5 5489.9 5527.8 5960.3 5962.1 5987.8 5992.3 6049.4 5460.7 5587.8 5597.9 5747.3 5756.6 5746.6 5754.1 5761.0 5769.9 5780.9 5689.3 5720.8 5724.3 5726.2 5773.7 5525.8 5630.7 5663.5 5692.9 5770.3 4297.5 4315.7 4340.5 4371.1 4402.2 3921.1 3952.3 3954.3 3979.0 4002.8 5039.9 5319.0 5398.6 5508.9 5538.2 5736.6 5752.6 5786.2 5821.9 5831.6 5457.5 5527.1 5530.4 5547.6 5569.4 4817.3 4932.3 4943.8 4955.8 4960.3 6023.4 6026.2 6056.7 6064.4 6066.7 5805.9 5827.4 5828.7 5833.6 5838.5 5775.8 5895.3 5907.1 5918.2 5928.2 5619.8 5638.5 5655.2 5671.4 5717.8 5624.3 5716.0 5728.7 5767.1 5781.0 5541.0 5584.7 5601.9 5602.4 5633.0 5593.3 5603.3 5606.7 5620.0 5657.7 5389.5 5415.6 5503.8 5509.4 5565.1 5548.8 5601.2 5608.2 5677.5 5758.5 5564.9 5572.0 5577.0 5582.3 5590.0 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#1] ext.html Cycles:180 Average:49877.19 Median:37641.62 stddev:94705.98 (251.6%) stddev-sans-first:94899.28 02:12:58 INFO - PROCESS | 19475 | Values: 563.6 598.9 605.0 621.3 669.2 37250.3 41737.0 41938.2 42045.2 42238.6 42006.6 42606.8 42702.4 42755.4 42816.4 8568.1 8747.0 8751.3 8807.5 8820.5 8544.4 8641.1 8659.2 8718.8 8746.4 8708.1 8713.7 8718.1 8755.9 8821.4 8619.4 8657.4 8678.2 8698.1 8716.8 8715.2 8736.6 8748.2 8748.5 8773.7 33566.0 37565.4 37750.4 37917.2 38148.8 3374.4 3523.2 3587.5 3625.2 3820.2 30260.1 30287.5 30633.5 30663.2 31048.4 4034.3 4150.5 4163.4 4170.6 4191.0 256749.0 262433.0 262483.0 262968.0 263681.0 34383.7 34669.1 34960.3 34964.3 35015.6 35541.6 37334.8 37577.4 37705.8 37931.0 15723.9 15874.0 15930.2 15964.7 16016.7 13378.1 13491.5 13520.0 13541.9 13576.0 8437.4 8481.9 8525.9 8532.2 8534.7 3377.8 3389.6 3403.9 3405.4 3424.2 1106.5 1207.3 1245.4 1245.7 1256.5 31768.7 32077.8 32131.8 32545.7 32721.2 1161.3 1199.3 1232.8 1235.8 1268.2 16561.8 16831.0 17062.9 17152.6 17351.3 457021.0 460237.0 466479.0 467630.0 470013.0 37244.0 37708.8 37718.0 37802.8 37885.6 1424.1 1424.7 1448.5 1450.5 1451.3 30347.0 30372.0 30504.4 31260.2 31484.5 48746.0 50336.0 50422.2 50556.7 50983.5 315340.0 316844.0 318072.0 318189.0 318496.0 27703.6 27841.7 28157.7 28394.3 28444.0 48112.5 48210.0 48844.0 49060.8 49410.0 39870.8 40055.6 40250.2 40639.0 41308.4 39977.2 40978.6 41000.6 41187.8 41413.4 40713.0 40906.0 42227.6 42334.0 45079.3 33784.3 35222.0 35896.6 36412.3 36422.8 27450.9 28085.9 28097.7 28381.7 28387.6 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#2] jquery.html Cycles:180 Average:27135.41 Median:12570.13 stddev:70498.25 (560.8%) stddev-sans-first:70667.45 02:12:58 INFO - PROCESS | 19475 | Values: 408.2 411.0 413.2 415.5 426.9 14897.8 17280.0 18344.6 19107.6 19203.8 18054.6 18384.0 18401.6 18463.5 18699.2 5587.9 5690.0 5773.7 5774.0 5847.9 5734.7 5738.1 5776.4 5800.7 5818.4 5511.9 5665.4 5733.5 5734.0 5749.9 5483.1 5676.6 5709.5 5719.4 5741.5 5129.8 5142.6 5145.9 5168.1 5194.7 22156.6 22603.1 22843.4 23035.3 23108.1 2012.7 2154.4 2296.8 2386.4 2474.1 9245.0 10274.7 10309.1 10317.5 10524.7 1941.4 1979.4 2001.5 2021.8 2055.9 80342.0 81124.2 81494.0 84741.0 85427.6 11229.8 11279.4 11281.7 11438.1 11455.5 13806.6 14571.4 16168.9 16186.3 16205.1 7972.9 8407.4 8505.2 8561.8 8711.9 8275.5 8278.4 8314.8 8403.7 8415.3 4778.3 4850.5 4855.4 4919.8 4930.3 2026.7 2037.9 2043.8 2058.4 2081.5 932.1 1015.3 1025.1 1054.4 1081.3 17537.0 17690.0 18406.6 19166.5 19482.3 995.8 997.3 1014.0 1017.6 1047.0 10571.4 10716.6 10783.1 10831.8 10908.2 349557.0 355415.0 460876.0 465201.0 470547.0 91716.0 93189.5 96446.5 98231.5 98340.5 1030.0 1096.3 1098.5 1098.5 1099.5 16797.6 17141.8 17200.5 17456.3 17631.2 40272.2 40677.4 40933.4 41951.8 42400.6 56452.4 56924.7 59096.0 59128.7 59957.0 8443.6 8460.5 8678.5 8822.9 8828.4 12321.4 12848.3 13119.8 13262.2 13519.7 11193.9 11619.9 11776.0 11821.9 11965.6 11142.2 11258.8 11440.3 11477.5 11521.8 11575.8 11928.9 11966.2 11981.8 12209.1 7374.4 8037.0 8166.1 8232.8 8881.1 11282.4 12465.6 12530.0 12542.2 12556.8 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#3] mootools.html Cycles:180 Average:5713.52 Median:4693.69 stddev:3251.17 (69.3%) stddev-sans-first:3244.68 02:12:58 INFO - PROCESS | 19475 | Values: 1474.1 1528.1 1669.5 1803.7 1812.3 7382.6 8169.4 8275.7 8837.0 8851.1 8147.2 8375.1 8469.7 8487.4 8516.5 2270.6 2314.5 2315.7 2317.7 2331.6 2105.3 2172.3 2266.0 2278.8 2280.0 2223.6 2224.9 2236.1 2240.1 2246.6 2166.4 2175.7 2176.6 2193.8 2203.1 2046.3 2048.0 2054.6 2067.9 2068.6 8448.9 8481.3 8504.9 8511.6 8559.3 5062.6 5188.0 5210.2 5227.2 5266.1 3270.9 3275.9 3409.7 3428.1 3428.5 1034.9 1048.3 1048.7 1066.2 1107.9 12007.5 12117.6 12156.3 12172.0 12239.1 4542.6 4618.3 4670.0 4717.4 4757.0 10156.3 10165.6 10181.0 10234.6 10267.6 5029.4 5107.0 5112.3 5124.4 5127.0 4115.9 4758.2 4779.5 4889.5 4928.0 3976.4 4011.6 4025.8 4106.9 4198.7 1276.9 1285.5 1300.9 1303.4 1318.9 991.5 1014.5 1021.7 1029.9 1037.8 5880.2 5888.7 5905.4 6102.3 6171.7 915.3 929.3 982.6 1011.1 1015.7 3868.3 3881.3 4017.8 4067.5 4131.8 10490.4 10854.5 10863.4 10876.1 11122.7 10801.5 10903.9 10904.8 10939.3 10956.7 7964.8 7990.4 8132.4 8157.2 8212.0 5683.1 5716.1 5817.8 5853.2 5860.0 9663.6 9782.4 10060.9 10066.6 10197.4 9952.4 9986.6 10278.4 10322.6 10392.7 6561.1 7133.5 7346.3 7445.6 7455.3 8496.0 8551.7 8552.4 8593.3 8611.4 7575.6 7739.8 7785.3 7814.3 7954.4 7532.4 7666.3 7707.4 7716.8 7798.3 6615.8 6624.2 6654.4 6662.4 6668.5 5059.6 5125.4 5223.0 5231.9 5275.8 5142.0 5243.6 5327.0 5333.3 5359.8 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#4] prototype.html Cycles:180 Average:4590.80 Median:5081.56 stddev:1335.90 (26.3%) stddev-sans-first:1300.85 02:12:58 INFO - PROCESS | 19475 | Values: 332.6 348.0 348.0 348.4 350.0 5472.8 5500.3 5522.9 5577.4 5580.9 5328.8 5350.2 5386.9 5387.2 5398.5 4094.7 4253.2 4265.7 4300.8 4330.5 4002.6 4177.9 4216.4 4242.0 4243.1 4218.8 4257.2 4257.2 4261.4 4274.8 4234.7 4267.1 4273.4 4281.6 4285.0 3432.1 3615.5 3621.0 3785.6 3819.7 5231.3 5248.9 5261.8 5308.5 5326.5 4725.8 4757.6 4768.6 4774.7 4775.1 5351.3 5663.2 5677.4 5713.8 5757.4 4030.4 4038.1 4043.0 4059.5 4074.7 5669.8 5813.6 5936.0 5939.1 5969.3 4063.0 4073.9 4076.6 4106.8 4118.9 4134.8 4143.1 4160.9 4173.9 4177.5 4629.6 4780.4 4798.2 4813.5 4835.0 5669.0 5677.1 5692.7 5731.8 5740.2 1411.7 1416.3 1423.8 1425.7 1428.4 846.3 891.5 902.6 921.7 924.9 4785.5 4863.7 4864.1 4870.5 4879.7 5085.2 5090.5 5144.5 5156.8 5176.6 4662.0 4842.7 4851.9 4888.6 4903.4 2701.2 2730.4 2733.7 2759.3 2776.4 5184.5 5217.3 5259.9 5318.8 5320.2 4885.7 5077.9 5201.2 5219.6 5228.3 5123.5 5167.1 5185.5 5232.3 5232.7 5037.5 5060.3 5063.3 5073.1 5140.2 4697.2 4970.1 4985.6 4992.6 5006.3 5684.5 5868.9 5999.2 6017.6 6030.7 3939.5 3975.9 4000.7 4015.2 4017.5 5680.0 5774.8 5854.9 5864.1 5872.7 5614.5 5650.9 5660.8 5661.4 5687.4 5556.0 5577.9 5599.0 5605.6 5615.5 5285.4 5490.9 5515.1 5536.7 5556.2 5655.8 5677.5 5683.8 5723.3 5733.9 5284.0 5526.4 5586.7 5610.4 5655.3 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - PROCESS | 19475 | [#5] yui.html Cycles:180 Average:14828.42 Median:4409.88 stddev:17541.96 (397.8%) stddev-sans-first:17559.33 02:12:58 INFO - PROCESS | 19475 | Values: 752.9 767.0 769.6 826.5 882.7 13452.6 14179.6 14213.9 14231.4 14309.7 12006.3 12266.9 12427.7 12484.0 12627.7 663.3 802.3 813.1 820.5 821.9 792.4 807.3 812.4 820.8 825.3 854.9 860.3 864.1 865.8 868.4 853.5 857.2 859.8 861.6 863.5 619.1 626.5 626.9 627.5 628.1 12673.7 12733.5 12734.6 12773.6 12802.4 13876.8 14056.6 14143.2 14239.0 14248.0 10991.9 11035.2 11068.6 11139.2 11289.0 3741.3 3761.7 3799.8 3824.9 3847.3 52099.0 52398.0 52770.5 52885.2 53004.5 10961.9 11130.0 11136.2 11298.1 11435.0 19574.5 19575.9 19730.3 19887.4 20432.5 7939.7 8056.1 8094.4 8118.0 8213.8 4331.2 4413.9 4460.1 4621.3 4732.4 3295.5 3395.0 3400.8 3404.5 3406.8 605.3 634.4 640.4 643.3 648.9 718.7 722.9 741.1 744.9 753.8 8529.4 8806.1 8860.9 9023.5 9216.9 716.8 743.5 747.6 753.1 753.2 4154.9 4244.0 4280.5 4363.2 4405.9 62678.4 63233.7 63770.7 64331.7 64659.7 57503.1 57581.0 58001.4 58513.7 59847.7 53181.2 53333.0 53338.2 53692.0 53734.5 8296.1 8353.2 8522.9 8743.7 8766.0 33598.8 34041.0 34301.8 34351.5 35262.8 44758.8 45024.8 45042.8 45149.5 46288.3 10503.7 11571.7 11698.4 12104.3 12150.7 11922.7 12776.7 12825.3 12954.2 13075.2 11943.0 12220.0 12462.4 12480.8 12546.7 12215.1 12377.8 12435.1 12710.9 13129.3 11220.3 11941.4 12328.1 12334.6 12638.2 10236.6 10389.6 10441.2 10517.2 10670.9 10060.3 10652.5 10693.2 10756.1 10878.7 02:12:58 INFO - PROCESS | 19475 | -------- Summary: end -------- 02:12:58 INFO - PROCESS | 19475 | 02:12:58 INFO - TEST-INFO | 19475: exit 0 02:12:58 INFO - TEST-OK | dromaeo_css | took 1108028ms 02:12:58 INFO - TEST-START | kraken 02:12:58 INFO - operating with platform_type : linux_ 02:12:58 INFO - Initialising browser for kraken test... 02:12:58 INFO - TEST-INFO | started process 19707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrjz4G/profile http://localhost:37255/getInfo.html) 02:13:01 INFO - PROCESS | 19707 | 02:13:01 INFO - PROCESS | 19707 | (process:19774): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:02 INFO - PROCESS | 19707 | __metrics Screen width/height:1600/1200 02:13:02 INFO - PROCESS | 19707 | colorDepth:24 02:13:02 INFO - PROCESS | 19707 | Browser inner width/height: 1024/697 02:13:02 INFO - PROCESS | 19707 | __metrics 02:13:03 ERROR - PROCESS | 19707 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:13:03 INFO - TEST-INFO | 19707: exit 0 02:13:03 INFO - Browser initialized. 02:13:03 INFO - Running cycle 1/1 for kraken test... 02:13:03 INFO - TEST-INFO | started process 19825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrjz4G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:05 INFO - PROCESS | 19825 | 02:13:05 INFO - PROCESS | 19825 | (process:19885): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:15 INFO - PROCESS | 19825 | RSS: Main: 161595392 02:13:15 INFO - PROCESS | 19825 | 02:13:17 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37255/tests/kraken/driver.html?testName=audio-beat-detection) 02:13:18 INFO - PROCESS | 19825 | RSS: Main: 166547456 02:13:18 INFO - PROCESS | 19825 | 02:13:21 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37255/tests/kraken/driver.html?testName=audio-dft) 02:13:21 INFO - PROCESS | 19825 | RSS: Main: 166916096 02:13:21 INFO - PROCESS | 19825 | 02:13:24 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37255/tests/kraken/driver.html?testName=audio-fft) 02:13:25 INFO - PROCESS | 19825 | RSS: Main: 161603584 02:13:25 INFO - PROCESS | 19825 | 02:13:27 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37255/tests/kraken/driver.html?testName=audio-oscillator) 02:13:28 INFO - PROCESS | 19825 | RSS: Main: 162119680 02:13:28 INFO - PROCESS | 19825 | 02:13:30 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:13:31 INFO - PROCESS | 19825 | RSS: Main: 162496512 02:13:31 INFO - PROCESS | 19825 | 02:13:34 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37255/tests/kraken/driver.html?testName=imaging-darkroom) 02:13:34 INFO - PROCESS | 19825 | RSS: Main: 162934784 02:13:34 INFO - PROCESS | 19825 | 02:13:38 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37255/tests/kraken/driver.html?testName=imaging-desaturate) 02:13:39 INFO - PROCESS | 19825 | RSS: Main: 161234944 02:13:39 INFO - PROCESS | 19825 | 02:13:41 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37255/tests/kraken/driver.html?testName=json-parse-financial) 02:13:42 INFO - PROCESS | 19825 | RSS: Main: 161771520 02:13:42 INFO - PROCESS | 19825 | 02:13:44 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:13:44 INFO - PROCESS | 19825 | RSS: Main: 162045952 02:13:44 INFO - PROCESS | 19825 | 02:13:46 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:13:47 INFO - PROCESS | 19825 | RSS: Main: 162238464 02:13:47 INFO - PROCESS | 19825 | 02:13:49 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:13:49 INFO - PROCESS | 19825 | RSS: Main: 162385920 02:13:49 INFO - PROCESS | 19825 | 02:13:52 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:13:53 INFO - PROCESS | 19825 | RSS: Main: 162725888 02:13:53 INFO - PROCESS | 19825 | 02:13:56 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:13:56 INFO - PROCESS | 19825 | RSS: Main: 162291712 02:13:56 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | Cycle 1(1): loaded http://localhost:37255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37255/tests/kraken/driver.html?testName=ai-astar) 02:13:58 INFO - PROCESS | 19825 | RSS: Main: 163995648 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | __start_tp_report 02:13:58 INFO - PROCESS | 19825 | _x_x_mozilla_page_load 02:13:58 INFO - PROCESS | 19825 | _x_x_mozilla_page_load_details 02:13:58 INFO - PROCESS | 19825 | |i|pagename|runs| 02:13:58 INFO - PROCESS | 19825 | |0;ai-astar;111;113;105;111;113;115;106;113;112;112 02:13:58 INFO - PROCESS | 19825 | |1;audio-beat-detection;159;132;163;206;132;160;157;146;183;135 02:13:58 INFO - PROCESS | 19825 | |2;audio-dft;163;165;165;166;165;165;165;181;162;163 02:13:58 INFO - PROCESS | 19825 | |3;audio-fft;77;76;75;162;77;77;76;77;165;77 02:13:58 INFO - PROCESS | 19825 | |4;audio-oscillator;94;94;176;92;94;94;138;94;94;142 02:13:58 INFO - PROCESS | 19825 | |5;imaging-gaussian-blur;120;118;118;118;120;119;120;118;120;120 02:13:58 INFO - PROCESS | 19825 | |6;imaging-darkroom;150;150;149;150;150;148;149;149;150;150 02:13:58 INFO - PROCESS | 19825 | |7;imaging-desaturate;96;97;95;96;97;96;96;96;95;96 02:13:58 INFO - PROCESS | 19825 | |8;json-parse-financial;59;58;60;58;57;59;59;59;58;58 02:13:58 INFO - PROCESS | 19825 | |9;json-stringify-tinderbox;60;60;59;60;59;59;58;58;59;61 02:13:58 INFO - PROCESS | 19825 | |10;stanford-crypto-aes;85;82;84;84;82;83;85;83;136;82 02:13:58 INFO - PROCESS | 19825 | |11;stanford-crypto-ccm;132;145;131;150;146;132;141;136;149;135 02:13:58 INFO - PROCESS | 19825 | |12;stanford-crypto-pbkdf2;177;174;173;172;171;169;171;171;176;175 02:13:58 INFO - PROCESS | 19825 | |13;stanford-crypto-sha256-iterative;67;72;71;67;68;67;66;71;66;66 02:13:58 INFO - PROCESS | 19825 | __end_tp_report 02:13:58 INFO - PROCESS | 19825 | __start_cc_report 02:13:58 INFO - PROCESS | 19825 | _x_x_mozilla_cycle_collect,749 02:13:58 INFO - PROCESS | 19825 | __end_cc_report 02:13:58 INFO - PROCESS | 19825 | __startTimestamp1463044438596__endTimestamp 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | ------- Summary: start ------- 02:13:58 INFO - PROCESS | 19825 | Number of tests: 14 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.18 (2.8%) stddev-sans-first:3.37 02:13:58 INFO - PROCESS | 19825 | Values: 111.0 113.0 105.0 111.0 113.0 115.0 106.0 113.0 112.0 112.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:159.50 stddev:23.52 (14.7%) stddev-sans-first:24.94 02:13:58 INFO - PROCESS | 19825 | Values: 159.0 132.0 163.0 206.0 132.0 160.0 157.0 146.0 183.0 135.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:5.42 (3.3%) stddev-sans-first:5.63 02:13:58 INFO - PROCESS | 19825 | Values: 163.0 165.0 165.0 166.0 165.0 165.0 165.0 181.0 162.0 163.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:36.70 (47.7%) stddev-sans-first:38.41 02:13:58 INFO - PROCESS | 19825 | Values: 77.0 76.0 75.0 162.0 77.0 77.0 76.0 77.0 165.0 77.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:94.00 stddev:29.83 (31.7%) stddev-sans-first:30.99 02:13:58 INFO - PROCESS | 19825 | Values: 94.0 94.0 176.0 92.0 94.0 94.0 138.0 94.0 94.0 142.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:120.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 02:13:58 INFO - PROCESS | 19825 | Values: 120.0 118.0 118.0 118.0 120.0 119.0 120.0 118.0 120.0 120.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:13:58 INFO - PROCESS | 19825 | Values: 150.0 150.0 149.0 150.0 150.0 148.0 149.0 149.0 150.0 150.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:13:58 INFO - PROCESS | 19825 | Values: 96.0 97.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 02:13:58 INFO - PROCESS | 19825 | Values: 59.0 58.0 60.0 58.0 57.0 59.0 59.0 59.0 58.0 58.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.95 (1.6%) stddev-sans-first:0.97 02:13:58 INFO - PROCESS | 19825 | Values: 60.0 60.0 59.0 60.0 59.0 59.0 58.0 58.0 59.0 61.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:83.50 stddev:16.69 (20.0%) stddev-sans-first:17.66 02:13:58 INFO - PROCESS | 19825 | Values: 85.0 82.0 84.0 84.0 82.0 83.0 85.0 83.0 136.0 82.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:143.00 stddev:7.39 (5.2%) stddev-sans-first:7.30 02:13:58 INFO - PROCESS | 19825 | Values: 132.0 145.0 131.0 150.0 146.0 132.0 141.0 136.0 149.0 135.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:2.56 (1.5%) stddev-sans-first:2.24 02:13:58 INFO - PROCESS | 19825 | Values: 177.0 174.0 173.0 172.0 171.0 169.0 171.0 171.0 176.0 175.0 02:13:58 INFO - PROCESS | 19825 | 02:13:58 INFO - PROCESS | 19825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.33 (3.5%) stddev-sans-first:2.44 02:13:58 INFO - PROCESS | 19825 | Values: 67.0 72.0 71.0 67.0 68.0 67.0 66.0 71.0 66.0 66.0 02:13:58 INFO - PROCESS | 19825 | -------- Summary: end -------- 02:13:58 INFO - PROCESS | 19825 | 02:13:59 INFO - TEST-INFO | 19825: exit 0 02:13:59 INFO - TEST-OK | kraken | took 60320ms 02:13:59 INFO - SUITE-END | took 1168s 02:13:59 INFO - Completed test suite (00:19:28) 02:13:59 INFO - javascript benchmark 02:13:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6949.563056303577, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.610548681415, 3141.450246206913, 3183.5383869338953, 3189.5215717642336, 3202.823844688541, 5352.759125839337, 5357.30355053843, 5357.544608708265, 5377.623566350357, 5537.889242215163, 5158.638895277332, 5213.113770658988, 5233.476652334764, 5251.396089449714, 5304.389995150559, 4804.567588917005, 4897.902041959159, 4914.213725803872, 4931.211006239003, 4932.827351042714, 4849.951500485003, 4990.30135780991, 5015.699058056528, 5049.596032317424, 5075.949240507584, 4854.781534830923, 4960.2559616057515, 4964.180910149821, 5009.4239162496415, 5019.272205530214, 4919.065377578248, 4936.456989731127, 4939.259111133323, 4961.479044700291, 4983.177775667011, 4870.732109733964, 4893.241547560134, 4897.926531102036, 4906.386701662293, 4948.0, 5063.670861393997, 5199.168133098686, 5268.604854635918, 5291.708956007418, 5304.761285742151, 5688.800891968761, 5694.601377903548, 5741.081426971707, 5766.62516936402, 5785.652860828363, 5759.107338362561, 5802.245708057925, 5833.504152147073, 5856.355800861902, 5886.7939622113445, 5424.891502169935, 5466.945330546683, 5475.534579560782, 5489.862753431196, 5527.834164975017, 5960.284765828128, 5962.07587823888, 5987.760489580455, 5992.250968628921, 6049.425304596057, 5460.672359658433, 5587.776488940478, 5597.944020559824, 5747.3103227612955, 5756.597038207369, 5746.597738158289, 5754.079347304411, 5761.0, 5769.884602308014, 5780.88438231233, 5689.317281926195, 5720.828375148669, 5724.284464441945, 5726.198332233491, 5773.682447465346, 5525.751341189656, 5630.662160270397, 5663.490285874291, 5692.9146062809095, 5770.336411312753, 4297.548757380492, 4315.6763242756915, 4340.544242854455, 4371.0820727646915, 4402.163588918095, 3921.137349783043, 3952.3405952440417, 3954.3277642800217, 3978.980105099456, 4002.799860006988, 5039.899202015939, 5319.0, 5398.595105367113, 5508.91736623951, 5538.224648549206, 5736.627119237236, 5752.626079304831, 5786.1610066540115, 5821.854453638608, 5831.620944638585, 5457.454254574511, 5527.060399732055, 5530.446955304437, 5547.583931205176, 5569.415211402826, 4817.349657796222, 4932.309476673268, 4943.752812359367, 4955.82654607087, 4960.330355402047, 6023.367546407651, 6026.186464827192, 6056.697165141725, 6064.363241859542, 6066.696665166724, 5805.854853628524, 5827.446392592697, 5828.737706803204, 5833.649981001154, 5838.532917366516, 5775.768969241351, 5895.322037965518, 5907.054871220584, 5918.171455996078, 5928.199693041384, 5619.775208991595, 5638.5489160867855, 5655.179998900054, 5671.376148623565, 5717.799877004285, 5624.29696287964, 5715.971125197504, 5728.713564321851, 5767.106098554731, 5780.971095144498, 5541.0, 5584.748686309207, 5601.887962240814, 5602.411746766694, 5633.014222511126, 5593.272874526286, 5603.299587551556, 5606.747696353756, 5619.9719001406365, 5657.745401457027, 5389.487998640123, 5415.620906536505, 5503.839367808983, 5509.421510741475, 5565.081761509306, 5548.833534993957, 5601.187827765033, 5608.158776183442, 5677.489025987681, 5758.452946970031, 5564.860878478071, 5572.0, 5576.972115139399, 5582.33012038558, 5589.972050139723], "value": 5308.023642120516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5829486180228, 598.8532809461681, 604.9987271066382, 621.3289647181043, 669.2069897171849, 37250.25499490012, 41737.0, 41938.16123677528, 42045.159096818046, 42238.57761422385, 42006.57993420072, 42606.78696606521, 42702.35946460805, 42755.358669619905, 42816.35775463363, 8568.143185681429, 8747.037825839152, 8751.3436492263, 8807.515586642732, 8820.514871682055, 8544.444611100289, 8641.092685268051, 8659.220670139686, 8718.782030449258, 8746.38775285727, 8708.129187081273, 8713.738587842376, 8718.128187181263, 8755.868661970075, 8821.382503224777, 8619.396642235015, 8657.437266577652, 8678.175573320525, 8698.130186981283, 8716.782080447976, 8715.215630593213, 8736.563171841446, 8748.168923952278, 8748.518831464267, 8773.736787896374, 33565.993020209185, 37565.43651845225, 37750.433743493595, 37917.24165516674, 38148.80925595382, 3374.409478341305, 3523.2248905241063, 3587.515685382466, 3625.2205775758075, 3820.1595648957186, 30260.092197234117, 30287.545686814716, 30633.540496892565, 30663.2334191647, 31048.379032419452, 4034.334334834749, 4150.543440221573, 4163.39630753539, 4170.624643782044, 4190.979045104786, 256749.0, 262433.0, 262483.0, 262968.0, 263681.0, 34383.65616343854, 34669.1332716679, 34960.30079398398, 34964.300713986086, 35015.64984350124, 35541.64458355383, 37334.813325933195, 37577.43633845494, 37705.81147094247, 37931.0, 15723.921380393025, 15874.0, 15930.203489825462, 15964.680706385807, 16016.679666406606, 13378.063535552417, 13491.460341586422, 13520.0, 13541.932290338485, 13576.049676522745, 8437.367197460215, 8481.915180848237, 8525.914740852637, 8532.23209911111, 8534.658613655385, 3377.831108444568, 3389.5932488101585, 3403.897883063512, 3405.3700065487965, 3424.229548351601, 1106.4799544214206, 1207.3178654060428, 1245.3959829482694, 1245.682351000489, 1256.4597223193932, 31768.682313176574, 32077.839610801795, 32131.839340803148, 32545.67454325474, 32721.18197045093, 1161.3380373187372, 1199.2924174736947, 1232.7904256276454, 1235.8022716365338, 1268.1693490763564, 16561.83438165627, 16831.0, 17062.914685426742, 17152.571185720455, 17351.3059477622, 457021.0, 460237.0, 466479.0, 467630.0, 470013.0, 37244.0, 37708.811455942545, 37718.0, 37802.81098594544, 37885.62114378821, 1424.1241636393543, 1424.7364237616075, 1448.4857875454063, 1450.5068276785944, 1451.2816156002634, 30347.0, 30372.0, 30504.389912202074, 31260.218494537818, 31484.527732083578, 48746.0, 50336.0, 50422.2436663443, 50556.747216263684, 50983.49016509787, 315340.0, 316844.0, 318072.0, 318189.0, 318496.0, 27703.584446233726, 27841.721582783914, 28157.71842281551, 28394.290142746595, 28444.004459843807, 48112.518874810805, 48210.0, 48844.0, 49060.75469622772, 49410.0, 39870.80064599775, 40055.56219381054, 40250.1949961005, 40639.0, 41308.38037429381, 39977.20045599013, 40978.59021409748, 41000.58999410087, 41187.794061030705, 41413.378799318634, 40713.0, 40906.0, 42227.57772422236, 42334.0, 45079.32381014353, 33784.32431351408, 35222.0, 35896.64103358933, 36412.27175456529, 36422.81788591146, 27450.862745686143, 28085.859570702833, 28097.71902280951, 28381.716182837907, 28387.574186387636], "value": 18081.314983640095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.1734487662485, 410.96301332880046, 413.17983802152725, 415.54705371145445, 426.94022836802856, 14897.77653335201, 17280.0, 18344.63310733788, 19107.61784764304, 19203.807961920378, 18054.638907221848, 18384.0, 18401.631967360678, 18463.538411539685, 18699.158537865795, 5587.888242235163, 5690.0, 5773.682447465388, 5773.971130144343, 5847.941520584804, 5734.7419366128415, 5738.110592858114, 5776.422357764211, 5800.651960882339, 5818.389069147742, 5511.889762204773, 5665.3768085510565, 5733.541316694655, 5734.0, 5749.913751293734, 5483.095289277265, 5676.574256930726, 5709.486146246816, 5719.370869204384, 5741.511971482387, 5129.794808207667, 5142.588592912558, 5145.922811157836, 5168.069747445458, 5194.740262986836, 22156.556868862695, 22603.095876164934, 22843.42891427711, 23035.308940731804, 23108.0756769729, 2012.7282816819688, 2154.429076294783, 2296.827737919646, 2386.355683965337, 2474.0598572542317, 9244.953775231148, 10274.7431314217, 10309.123724483428, 10317.484125793755, 10524.684259472151, 1941.3787587971854, 1979.4061781465502, 2001.4996250937265, 2021.787712290203, 2055.8972051397373, 80342.0, 81124.18875811226, 81494.0, 84741.0, 85427.57286213654, 11229.831552526719, 11279.436028198557, 11281.717957050976, 11438.142139339583, 11455.484503197376, 13806.585802425943, 14571.41714331415, 16168.919155404148, 16186.271617777229, 16205.10871902033, 7972.880406793903, 8407.369447291356, 8505.234528892306, 8561.828763424697, 8711.869321960176, 8275.54484503358, 8278.379121565908, 8314.750557483285, 8403.747887563382, 8415.284700800501, 4778.331033655221, 4850.485746773316, 4855.441624213261, 4919.7540122993705, 4930.309756634074, 2026.7466566679166, 2037.8777273363646, 2043.83649308055, 2058.423641380416, 2081.5004398944448, 932.137772560379, 1015.2740790334946, 1025.0620682075967, 1054.4306074719718, 1081.324172392255, 17537.0, 17690.0, 18406.63186736258, 19166.520836978907, 19482.318118865773, 995.8058178655093, 997.2620261006948, 1014.0, 1017.6336518853207, 1046.984295235572, 10571.36571805694, 10716.624918127984, 10783.13734901206, 10831.83752243717, 10908.236423450282, 349557.00885982136, 355415.0, 460876.0, 465201.0, 470547.0, 91716.0, 93189.5340523293, 96446.51776741071, 98231.50884245533, 98340.50829745806, 1029.994850025745, 1096.276457538037, 1098.4562641492512, 1098.5441041967495, 1099.4722533183956, 16797.580060498585, 17141.828581714024, 17200.483985480456, 17456.30174792994, 17631.206595702966, 40272.1945561093, 40677.389839151845, 40933.38599920944, 41951.7902410486, 42400.57599423966, 56452.43547564636, 56924.71537642451, 59096.0, 59128.704356477945, 59957.0, 8443.577821109044, 8460.492370457792, 8678.499021165775, 8822.867656985021, 8828.42615230008, 12321.44553495077, 12848.293343866177, 13119.803202952155, 13262.204267743966, 13519.662008449868, 11193.944030279796, 11619.883801161881, 11776.0, 11821.881781182077, 11965.581204657796, 11142.220044596801, 11258.831117533407, 11440.256383335056, 11477.48351324209, 11521.769564608829, 11575.76848463043, 11928.940355298168, 11966.162368634112, 11981.820272696092, 12209.145359824726, 7374.410047196104, 8037.0, 8166.142555031874, 8232.753017409488, 8881.111888811067, 11282.379469129277, 12465.563705270271, 12530.0, 12542.1847579907, 12556.811647825472], "value": 9213.498330112458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.1228968763583, 1528.0984219310608, 1669.4574263364402, 1803.7294405839132, 1812.3384964487966, 7382.630868456569, 8169.387295952798, 8275.710350137746, 8837.0, 8851.07063758305, 8147.226013528705, 8375.078741338448, 8469.66121355145, 8487.40588158829, 8516.489010659365, 2270.5912935671613, 2314.5486630107134, 2315.6642286868396, 2317.6755254264417, 2331.62693968965, 2105.3368189020484, 2172.3482955113404, 2265.954680906381, 2278.8063014643776, 2279.977200227993, 2223.5997520446313, 2224.8998795054263, 2236.083205885587, 2240.1039584166383, 2246.629306164481, 2166.360923527563, 2175.6845257437662, 2176.640854259061, 2193.813525850305, 2203.06369792839, 2046.2531176120758, 2048.0, 2054.6301665700166, 2067.865588736727, 2068.6483297839254, 8448.90164278646, 8481.279091277249, 8504.914950850474, 8511.57442127891, 8559.315254779603, 5062.620303477254, 5188.014277287303, 5210.166373380279, 5227.163653815372, 5266.052110620087, 3270.9182270443193, 3275.8853440129483, 3409.6760807723226, 3428.125827913866, 3428.468587368962, 1034.932729372596, 1048.2609760119099, 1048.7430579507993, 1066.193243806159, 1107.855978722769, 12007.519699212022, 12117.636470905887, 12156.270623762513, 12172.0, 12239.082068844873, 4542.568455996675, 4618.284165954283, 4670.0, 4717.386739723814, 4756.9524304756505, 10156.339837910513, 10165.644202453026, 10180.98190180976, 10234.59061637541, 10267.640632577824, 5029.446760856303, 5107.0, 5112.284280200774, 5124.359455068116, 5126.974365128151, 4115.8971025724595, 4758.214894542361, 4779.545943135397, 4889.535494128052, 4927.96512732323, 3976.363781794899, 4011.5988401159652, 4025.81883815229, 4106.905478206137, 4198.748075115503, 1276.9170003949714, 1285.5307812648316, 1300.8504022037587, 1303.3548393545257, 1318.940647670857, 991.5191132300828, 1014.4724743133529, 1021.7190272675074, 1029.9279050466396, 1037.7509397744486, 5880.235569375954, 5888.705564721747, 5905.350411454737, 6102.328743838174, 6171.722272497748, 915.2997956563235, 929.256594724218, 982.5922242269521, 1011.1102230037667, 1015.7409860485677, 3868.3423817951016, 3881.320768865494, 4017.779022153751, 4067.491563554556, 4131.793410329472, 10490.423026733602, 10854.45727713611, 10863.402512861869, 10876.129909607213, 11122.666320010412, 10801.459927003776, 10903.945480272707, 10904.78190436187, 10939.343639381663, 10956.671299861016, 7964.761057168294, 7990.4007199460275, 8132.430729848854, 8157.184281571914, 8212.0, 5683.119116536944, 5716.085426331767, 5817.825465236049, 5853.180554722428, 5859.970700146472, 9663.613455461984, 9782.41305521671, 10060.949695251476, 10066.597336106766, 10197.439140847324, 9952.353097048668, 9986.60053597877, 10278.383297002203, 10322.638707645196, 10392.740181495523, 6561.081448597105, 7133.536320139175, 7346.265373462611, 7445.590492522963, 7455.291747283999, 8495.980482342158, 8551.74344769658, 8552.401331906707, 8593.31253499731, 8611.440256383315, 7575.621218939141, 7739.806504837424, 7785.260400261966, 7814.296713295831, 7954.403419743427, 7532.359749421361, 7666.310032097138, 7707.383409327353, 7716.8456630868195, 7798.25916537928, 6615.834604134935, 6624.171978502687, 6654.367835055662, 6662.433693136138, 6668.466522678077, 5059.569936555286, 5125.359330083739, 5223.0, 5231.869203269796, 5275.815346463009, 5141.974290128525, 5243.55429788457, 5326.97336513315, 5333.253344531691, 5359.758810853443], "value": 4577.756078643818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6407479921685, 347.9843407046684, 348.0, 348.4077068982729, 349.99999999999994, 5472.753726082326, 5500.257465242191, 5522.889542209158, 5577.410438025164, 5580.944190558093, 5328.760205790739, 5350.170723537848, 5386.8922621547545, 5387.19192121182, 5398.4601539846, 4094.7306335036087, 4253.1706317268145, 4265.658747300224, 4300.849680058743, 4330.523642399334, 4002.6197511236387, 4177.916441671165, 4216.430781844458, 4242.0, 4243.066525364415, 4218.810153543098, 4257.169851878885, 4257.233697934371, 4261.360795880627, 4274.829006839723, 4234.66122710184, 4267.1252393259465, 4273.380359847836, 4281.587076264826, 4285.0, 3432.1248081738995, 3615.4938308636547, 3621.0042238384654, 3785.6025117362556, 3819.656230939229, 5231.2937753403185, 5248.895022099575, 5261.789528418859, 5308.469153084699, 5326.493983071602, 4725.849738369034, 4757.643176761757, 4768.5946694531, 4774.665773395864, 4775.06333604834, 5351.304330437058, 5663.207150998864, 5677.432256774331, 5713.828585142411, 5757.41671040463, 4030.3954406838916, 4038.1318016626274, 4043.0, 4059.4925634295714, 4074.694397920168, 5669.773209071632, 5813.593048486608, 5936.0, 5939.07944268639, 5969.31352894414, 4062.984253936516, 4073.89815254621, 4076.5719599442223, 4106.774127422961, 4118.855840045584, 4134.772587507656, 4143.109231515239, 4160.9375859362135, 4173.853915112956, 4177.456930599003, 4629.634257893929, 4780.398566480268, 4798.23228283473, 4813.470518242991, 4834.975825120922, 5669.0, 5677.091665333527, 5692.743826527816, 5731.799387021434, 5740.196372507852, 1411.6894283257666, 1416.2918540729636, 1423.8220222472191, 1425.7026106243477, 1428.357239242345, 846.2975730143966, 891.4873947480095, 902.6479672927563, 921.7188757428914, 924.8797656304772, 4785.473597904228, 4863.708177509361, 4864.100141473838, 4870.512948705101, 4879.682820616648, 5085.2372144177925, 5090.498303000623, 5144.459831717691, 5156.845294641167, 5176.567013503647, 4662.0, 4842.709437433765, 4851.878703032452, 4888.560029597354, 4903.376693468977, 2701.2436517775054, 2730.4266104118356, 2733.72662733725, 2759.323965628434, 2776.4308316795414, 5184.533391994663, 5217.278298161597, 5259.868503287448, 5318.840434786963, 5320.158655623364, 4885.731284779371, 5077.873053173626, 5201.219817027476, 5219.608529360313, 5228.346456692913, 5123.462036486116, 5167.088177374396, 5185.48145185486, 5232.293640358503, 5232.73836308183, 5037.496250375079, 5060.316857224375, 5063.316452279042, 5073.14830087023, 5140.228965655182, 4697.21505827797, 4970.105381031449, 4985.5791099536455, 4992.5756310714, 5006.274090256965, 5684.516816070515, 5868.94131058684, 5999.160117583455, 6017.585867321089, 6030.698465076816, 3939.5075615548058, 3975.920481590294, 4000.6999475038906, 4015.2170326787164, 4017.4777278953547, 5680.0, 5774.769009239583, 5854.853628659318, 5864.120381942743, 5872.677002764889, 5614.494695477427, 5650.943490565041, 5660.801871934463, 5661.433856614471, 5687.402822703722, 5556.0, 5577.932137324537, 5598.972005139948, 5605.645628835817, 5615.522680572197, 5285.392179899207, 5490.862728431821, 5515.124857548452, 5536.667799932017, 5556.249906262603, 5655.802046928337, 5677.460641239076, 5683.801066962802, 5723.255976723, 5733.913991290051, 5283.973580132075, 5526.4078349073425, 5586.664800112007, 5610.438956104357, 5655.349634791887], "value": 4167.7081282146255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.9058867641545, 766.9923300766991, 769.6382700130937, 826.516487854605, 882.717530390275, 13452.596422107341, 14179.574612761608, 14213.857861421395, 14231.359588818503, 14309.713805723892, 12006.27962322259, 12266.877331226686, 12427.68930776731, 12484.0, 12627.684307892285, 663.2505269045971, 802.3060053054124, 813.1137060603941, 820.4502983001404, 821.9314890642171, 792.3581898662102, 807.2855522862279, 812.4353574265888, 820.8071103290722, 825.2613910550054, 854.8803167556516, 860.2859626510013, 864.1358641358642, 865.7705707987388, 868.3530769576674, 853.4580541356221, 857.1685465098844, 859.776458120893, 861.6036623153326, 863.4689665855485, 619.1424876545972, 626.4894111299277, 626.8808926304033, 627.5356236385088, 628.1174949196386, 12673.683157921034, 12733.490660373574, 12734.554290599785, 12773.61679149627, 12802.359882005863, 13876.791848122186, 14056.648583785385, 14143.151410915276, 14239.0, 14248.0, 10991.890081099247, 11035.172362072877, 11068.612598559012, 11139.220254582182, 11289.0, 3741.28915506053, 3761.680257178143, 3799.8290076946328, 3824.9043773905596, 3847.2690188864026, 52099.0, 52398.0, 52770.47229527694, 52885.206721898816, 53004.46995530034, 10961.945190273998, 11130.0, 11136.171692582873, 11298.096152307795, 11435.0, 19574.510637234183, 19575.902120489307, 19730.309439169847, 19887.403377898685, 20432.489187770127, 7939.682412703427, 8056.113827478973, 8094.392920530984, 8117.959410202911, 8213.79465513367, 4331.242032644274, 4413.889652758642, 4460.107978404268, 4621.329907163443, 4732.361131247238, 3295.489199174132, 3395.0324157615455, 3400.795952242873, 3404.5403870477166, 3406.795592264472, 605.2615808713363, 634.4068296143121, 640.3596403596404, 643.2988043033023, 648.9123968264319, 718.6730037832774, 722.9313215244543, 741.1143683298407, 744.9106107267163, 753.8379248461607, 8529.445586036887, 8806.119388061143, 8860.8670869937, 9023.548822558845, 9216.861747073799, 716.7634680555404, 743.5278598090143, 747.5925620536821, 753.148941695891, 753.2091304130751, 4154.91690166195, 4243.978780106141, 4280.4863416390235, 4363.214621368184, 4405.867823965286, 62678.37321626816, 63233.68383158055, 63770.68114659397, 64331.67834160893, 64659.67670161619, 57503.13745293824, 57581.0, 58001.4199857996, 58513.70743146342, 59847.700761495915, 53181.2022819658, 53333.0, 53338.19992700113, 53692.0, 53734.46265537295, 8296.087430382533, 8353.24820766134, 8522.872156917527, 8743.650253989768, 8766.0, 33598.83200583982, 34041.0, 34301.828490857384, 34351.48472772961, 35262.823685881405, 44758.77620611876, 45024.77487612672, 45042.77478612586, 45149.54850451453, 46288.30567541422, 10503.684889453329, 11571.727110017722, 11698.35659038727, 12104.334261615695, 12150.724173961607, 11922.701932451759, 12776.74446511083, 12825.294608796607, 12954.222746635232, 13075.150115242479, 11943.0, 12219.981468360049, 12462.43919023628, 12480.75038499243, 12546.686332841751, 12215.144939854124, 12377.814332784836, 12435.06736994711, 12710.936445317715, 13129.277889716157, 11220.270682405617, 11941.402929853299, 12328.137030407785, 12334.568290109803, 12638.178518396275, 10236.590536378759, 10389.636362727268, 10441.216908731723, 10517.21120915919, 10670.89329106699, 10060.295779295378, 10652.520636571218, 10693.198010149114, 10756.085732712494, 10878.673639790819], "value": 6676.7559578780165, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 105.0, 111.0, 113.0, 115.0, 106.0, 113.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 163.0, 206.0, 132.0, 160.0, 157.0, 146.0, 183.0, 135.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 166.0, 165.0, 165.0, 165.0, 181.0, 162.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 162.0, 77.0, 77.0, 76.0, 77.0, 165.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 176.0, 92.0, 94.0, 94.0, 138.0, 94.0, 94.0, 142.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 118.0, 120.0, 119.0, 120.0, 118.0, 120.0, 120.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 150.0, 148.0, 149.0, 149.0, 150.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 58.0, 57.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 58.0, 58.0, 59.0, 61.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 84.0, 82.0, 83.0, 85.0, 83.0, 136.0, 82.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 145.0, 131.0, 150.0, 146.0, 132.0, 141.0, 136.0, 149.0, 135.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 173.0, 172.0, 171.0, 169.0, 171.0, 171.0, 176.0, 175.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 71.0, 67.0, 68.0, 67.0, 66.0, 71.0, 66.0, 66.0], "value": 68.1, "unit": "score"}]}]} 02:13:59 INFO - Return code: 0 02:13:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:13:59 ERROR - # TBPL SUCCESS # 02:13:59 INFO - Running post-action listener: _resource_record_post_action 02:13:59 INFO - ##### 02:13:59 INFO - ##### Finished run-tests step (success) 02:13:59 INFO - ##### 02:13:59 INFO - Running post-run listener: _resource_record_post_run 02:14:00 INFO - Total resource usage - Wall time: 1186s; CPU: 26.0%; Read bytes: 0; Write bytes: 549535744; Read time: 0; Write time: 409300 02:14:00 INFO - TinderboxPrint: CPU usage
25.7% 02:14:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:14:00 INFO - TinderboxPrint: I/O write bytes / time
549,535,744 / 409,300 02:14:00 INFO - TinderboxPrint: CPU idle
7,028.4 (74.2%) 02:14:00 INFO - TinderboxPrint: CPU user
2,396.7 (25.3%) 02:14:00 INFO - TinderboxPrint: Swap in / out
0 / 0 02:14:00 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 254365696; Read time: 0; Write time: 201976 02:14:00 INFO - run-tests - Wall time: 1170s; CPU: 26.0%; Read bytes: 0; Write bytes: 295170048; Read time: 0; Write time: 207324 02:14:00 INFO - Running post-run listener: _upload_blobber_files 02:14:00 INFO - Blob upload gear active. 02:14:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:14:00 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 02:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:14:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:02 INFO - (blobuploader) - INFO - Done attempting. 02:14:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:14:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:14:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:03 INFO - (blobuploader) - INFO - Done attempting. 02:14:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:03 INFO - Return code: 0 02:14:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:14:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef66dc759a6e083e0408bd42ac9bd468e02e1ff52a88d9322b22463197e16ba59ae49086795b7f0dce3c78a6bd855dd1e1f338f03b237d666f503379c8fa4cce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18207a3604725927c7f5b70c7b1a4068798715eb36ea5c96a7f189aec85fdda911875566d8086600310aa13e2c5ccc8b10e184687f67fe6a590118faf8ed65c1"} 02:14:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:14:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:14:03 INFO - Contents: 02:14:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef66dc759a6e083e0408bd42ac9bd468e02e1ff52a88d9322b22463197e16ba59ae49086795b7f0dce3c78a6bd855dd1e1f338f03b237d666f503379c8fa4cce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18207a3604725927c7f5b70c7b1a4068798715eb36ea5c96a7f189aec85fdda911875566d8086600310aa13e2c5ccc8b10e184687f67fe6a590118faf8ed65c1"} 02:14:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:03 INFO - Copying logs to upload dir... 02:14:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:14:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.041420 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-12 02:14:01.998489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 02:14:02.002054) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 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/Mozilla-Inbound/sha512/ef66dc759a6e083e0408bd42ac9bd468e02e1ff52a88d9322b22463197e16ba59ae49086795b7f0dce3c78a6bd855dd1e1f338f03b237d666f503379c8fa4cce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18207a3604725927c7f5b70c7b1a4068798715eb36ea5c96a7f189aec85fdda911875566d8086600310aa13e2c5ccc8b10e184687f67fe6a590118faf8ed65c1"} build_url:https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005324 build_url: 'https://queue.taskcluster.net/v1/task/D1R5cbGQSSOHi8IxEHb8jA/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/Mozilla-Inbound/sha512/ef66dc759a6e083e0408bd42ac9bd468e02e1ff52a88d9322b22463197e16ba59ae49086795b7f0dce3c78a6bd855dd1e1f338f03b237d666f503379c8fa4cce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18207a3604725927c7f5b70c7b1a4068798715eb36ea5c96a7f189aec85fdda911875566d8086600310aa13e2c5ccc8b10e184687f67fe6a590118faf8ed65c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 02:14:02.016729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:14:02.017111) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463042785.551424-278929681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002125 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:14:02.099697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 02:14:02.100060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 02:14:02.100400) ========= ========= Total master_lag: 0.14 =========