builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1469618584.03 results: success (0) buildid: 20160726081123 builduid: d55b11d35c3148cb8ff39a91e15f3ac4 revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.026066) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.026521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.026800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.042429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.042705) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:23:04-- 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% 46.4M=0s 2016-07-27 04:23:04 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.139374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.139737) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:04.189172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:23:04.189527) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:23:04,425 truncating revision to first 12 chars 2016-07-27 04:23:04,425 Setting DEBUG logging. 2016-07-27 04:23:04,425 attempt 1/10 2016-07-27 04:23:04,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebd239b4cbfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:23:05,594 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:23:05.730831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:05.731279) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:05.731801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:05.732171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:05.743535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 04:23:05.743870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:06 INFO - MultiFileLogger online at 20160727 04:23:06 in /builds/slave/test 04:23:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:23:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:06 INFO - {'append_to_log': False, 04:23:06 INFO - 'base_work_dir': '/builds/slave/test', 04:23:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:23:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:06 INFO - 'branch': 'Mozilla-Aurora', 04:23:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:06 INFO - 'config_files': ('talos/linux_config.py',), 04:23:06 INFO - 'default_actions': ('clobber', 04:23:06 INFO - 'read-buildbot-config', 04:23:06 INFO - 'download-and-extract', 04:23:06 INFO - 'populate-webroot', 04:23:06 INFO - 'create-virtualenv', 04:23:06 INFO - 'install', 04:23:06 INFO - 'run-tests'), 04:23:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:06 INFO - 'download_minidump_stackwalk': True, 04:23:06 INFO - 'download_symbols': 'ondemand', 04:23:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:06 INFO - 'installer_path': 'installer.exe', 04:23:06 INFO - 'log_level': 'info', 04:23:06 INFO - 'log_name': 'talos', 04:23:06 INFO - 'log_to_console': True, 04:23:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:06 INFO - 'opt_config_files': (), 04:23:06 INFO - 'pip_index': False, 04:23:06 INFO - 'sps_profile': False, 04:23:06 INFO - 'sps_profile_interval': 0, 04:23:06 INFO - 'suite': 'dromaeojs-e10s', 04:23:06 INFO - 'system_bits': '32', 04:23:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:06 INFO - 'title': 'talos-linux64-ix-016', 04:23:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:06 INFO - 'use_talos_json': True, 04:23:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:06 INFO - 'work_dir': 'build'} 04:23:06 INFO - ##### 04:23:06 INFO - ##### Running clobber step. 04:23:06 INFO - ##### 04:23:06 INFO - Running pre-action listener: _resource_record_pre_action 04:23:06 INFO - Running main action method: clobber 04:23:06 INFO - rmtree: /builds/slave/test/build 04:23:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:06 INFO - Running post-action listener: _resource_record_post_action 04:23:06 INFO - ##### 04:23:06 INFO - ##### Finished clobber step (success) 04:23:06 INFO - ##### 04:23:06 INFO - ##### 04:23:06 INFO - ##### Running read-buildbot-config step. 04:23:06 INFO - ##### 04:23:06 INFO - Running pre-action listener: _resource_record_pre_action 04:23:06 INFO - Running main action method: read_buildbot_config 04:23:06 INFO - Using buildbot properties: 04:23:06 INFO - { 04:23:06 INFO - "project": "", 04:23:06 INFO - "product": "firefox", 04:23:06 INFO - "script_repo_revision": "production", 04:23:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:23:06 INFO - "repository": "", 04:23:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:23:06 INFO - "buildid": "20160726081123", 04:23:06 INFO - "pgo_build": "True", 04:23:06 INFO - "basedir": "/builds/slave/test", 04:23:06 INFO - "buildnumber": 466, 04:23:06 INFO - "slavename": "talos-linux64-ix-016", 04:23:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:23:06 INFO - "platform": "ubuntu64_hw", 04:23:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:23:06 INFO - "branch": "mozilla-aurora", 04:23:06 INFO - "repo_path": "releases/mozilla-aurora", 04:23:06 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 04:23:06 INFO - "stage_platform": "linux64-pgo", 04:23:06 INFO - "builduid": "d55b11d35c3148cb8ff39a91e15f3ac4", 04:23:06 INFO - "slavebuilddir": "test" 04:23:06 INFO - } 04:23:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:23:06 INFO - Running post-action listener: _resource_record_post_action 04:23:06 INFO - ##### 04:23:06 INFO - ##### Finished read-buildbot-config step (success) 04:23:06 INFO - ##### 04:23:06 INFO - ##### 04:23:06 INFO - ##### Running download-and-extract step. 04:23:06 INFO - ##### 04:23:06 INFO - Running pre-action listener: _resource_record_pre_action 04:23:06 INFO - Running main action method: download_and_extract 04:23:06 INFO - mkdir: /builds/slave/test/build/tests 04:23:06 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')]} 04:23:06 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:07 INFO - Downloaded 1361 bytes. 04:23:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:07 INFO - Using the following test package requirements: 04:23:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:23:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'jsshell-linux-x86_64.zip'], 04:23:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:23:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:23:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23: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')]} 04:23:07 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:08 INFO - Downloaded 24494733 bytes. 04:23:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:09 INFO - Return code: 0 04:23:09 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23: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')]} 04:23:09 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:10 INFO - Downloaded 24494733 bytes. 04:23:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:11 INFO - Return code: 0 04:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:11 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:12 INFO - Downloaded 10833369 bytes. 04:23:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:23:12 INFO - Return code: 0 04:23:12 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')]} 04:23:12 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:14 INFO - Downloaded 63637001 bytes. 04:23:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:14 INFO - mkdir: /builds/slave/test/properties 04:23:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:14 INFO - Contents: 04:23:14 INFO - build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:15 INFO - Running post-action listener: _resource_record_post_action 04:23:15 INFO - Running post-action listener: set_extra_try_arguments 04:23:15 INFO - ##### 04:23:15 INFO - ##### Finished download-and-extract step (success) 04:23:15 INFO - ##### 04:23:15 INFO - ##### 04:23:15 INFO - ##### Running populate-webroot step. 04:23:15 INFO - ##### 04:23:15 INFO - Running pre-action listener: _resource_record_pre_action 04:23:15 INFO - Running main action method: populate_webroot 04:23:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:15 INFO - '--tppagecycles', 04:23:15 INFO - '7'], 04:23:15 INFO - 'tests': ['tsvgm']}}, 04:23:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['damp', 'tps']}, 04:23:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'tests': ['damp', 'tps']}, 04:23:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['dromaeo_dom']}, 04:23:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['a11yr', 04:23:15 INFO - 'ts_paint', 04:23:15 INFO - 'tpaint', 04:23:15 INFO - 'sessionrestore', 04:23:15 INFO - 'sessionrestore_no_auto_restore', 04:23:15 INFO - 'tabpaint']}, 04:23:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['tsvgx', 04:23:15 INFO - 'tsvgr_opacity', 04:23:15 INFO - 'tart', 04:23:15 INFO - 'tscrollx', 04:23:15 INFO - 'cart']}, 04:23:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:15 INFO - 'tsvgr_opacity', 04:23:15 INFO - 'tart', 04:23:15 INFO - 'tscrollx', 04:23:15 INFO - 'cart']}, 04:23:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'talos_options': ['--disable-e10s'], 04:23:15 INFO - 'tests': ['tp5o']}, 04:23:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'tests': ['tp5o']}, 04:23:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'talos_options': ['--disable-e10s', 04:23:15 INFO - '--xperf_path', 04:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:15 INFO - 'tests': ['tp5n']}, 04:23:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:15 INFO - 'talos_options': ['--xperf_path', 04:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:15 INFO - 'tests': ['tp5n']}}, 04:23:15 INFO - 'talos.zip': {'path': '', 04:23:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:15 INFO - Running post-action listener: _resource_record_post_action 04:23:15 INFO - ##### 04:23:15 INFO - ##### Finished populate-webroot step (success) 04:23:15 INFO - ##### 04:23:15 INFO - ##### 04:23:15 INFO - ##### Running create-virtualenv step. 04:23:15 INFO - ##### 04:23:15 INFO - Running pre-action listener: _resource_record_pre_action 04:23:15 INFO - Running main action method: create_virtualenv 04:23:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:15 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 04:23:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:15 INFO - Using real prefix '/usr' 04:23:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:15 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:17 INFO - Installing pip.................done. 04:23:17 INFO - Return code: 0 04:23:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:17 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:17 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 04:23:17 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 04:23:17 INFO - Using env: {'DISPLAY': ':0', 04:23:17 INFO - 'HOME': '/home/cltbld', 04:23:17 INFO - 'LANG': 'en_US.UTF-8', 04:23:17 INFO - 'LANGUAGE': 'en_US:en', 04:23:17 INFO - 'LOGNAME': 'cltbld', 04:23:17 INFO - 'MAIL': '/var/mail/cltbld', 04:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:17 INFO - 'MOZ_NO_REMOTE': '1', 04:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:17 INFO - 'NO_EM_RESTART': '1', 04:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:17 INFO - 'PWD': '/builds/slave/test', 04:23:17 INFO - 'SHELL': '/bin/bash', 04:23:17 INFO - 'SHLVL': '1', 04:23:17 INFO - 'TERM': 'linux', 04:23:17 INFO - 'TMOUT': '86400', 04:23:17 INFO - 'USER': 'cltbld', 04:23:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:17 INFO - '_': '/tools/buildbot/bin/python'} 04:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:17 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 04:23:17 INFO - Cleaning up... 04:23:17 INFO - Return code: 0 04:23:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:23:17 INFO - Using env: {'DISPLAY': ':0', 04:23:17 INFO - 'HOME': '/home/cltbld', 04:23:17 INFO - 'LANG': 'en_US.UTF-8', 04:23:17 INFO - 'LANGUAGE': 'en_US:en', 04:23:17 INFO - 'LOGNAME': 'cltbld', 04:23:17 INFO - 'MAIL': '/var/mail/cltbld', 04:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:17 INFO - 'MOZ_NO_REMOTE': '1', 04:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:17 INFO - 'NO_EM_RESTART': '1', 04:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:17 INFO - 'PWD': '/builds/slave/test', 04:23:17 INFO - 'SHELL': '/bin/bash', 04:23:17 INFO - 'SHLVL': '1', 04:23:17 INFO - 'TERM': 'linux', 04:23:17 INFO - 'TMOUT': '86400', 04:23:17 INFO - 'USER': 'cltbld', 04:23:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:17 INFO - '_': '/tools/buildbot/bin/python'} 04:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:18 INFO - Downloading/unpacking psutil>=3.1.1 04:23:18 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 04:23:18 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 04:23:18 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 04:23:18 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 04:23:18 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 04:23:18 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 04:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:20 INFO - Installing collected packages: psutil 04:23:20 INFO - Running setup.py install for psutil 04:23:20 INFO - building 'psutil._psutil_linux' extension 04:23:20 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 04:23:20 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 04:23:20 INFO - building 'psutil._psutil_posix' extension 04:23:20 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 04:23:20 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 04:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:20 INFO - Successfully installed psutil 04:23:20 INFO - Cleaning up... 04:23:20 INFO - Return code: 0 04:23:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:20 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')]} 04:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:20 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')]} 04:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:23:20 INFO - Using env: {'DISPLAY': ':0', 04:23:20 INFO - 'HOME': '/home/cltbld', 04:23:20 INFO - 'LANG': 'en_US.UTF-8', 04:23:20 INFO - 'LANGUAGE': 'en_US:en', 04:23:20 INFO - 'LOGNAME': 'cltbld', 04:23:20 INFO - 'MAIL': '/var/mail/cltbld', 04:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:20 INFO - 'MOZ_NO_REMOTE': '1', 04:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:20 INFO - 'NO_EM_RESTART': '1', 04:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:20 INFO - 'PWD': '/builds/slave/test', 04:23:20 INFO - 'SHELL': '/bin/bash', 04:23:20 INFO - 'SHLVL': '1', 04:23:20 INFO - 'TERM': 'linux', 04:23:20 INFO - 'TMOUT': '86400', 04:23:20 INFO - 'USER': 'cltbld', 04:23:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:20 INFO - '_': '/tools/buildbot/bin/python'} 04:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:21 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 04:23:21 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 04:23:21 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 04:23:21 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 04:23:21 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 04:23:21 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 04:23:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:22 INFO - Installing collected packages: mozsystemmonitor 04:23:22 INFO - Running setup.py install for mozsystemmonitor 04:23:23 INFO - Successfully installed mozsystemmonitor 04:23:23 INFO - Cleaning up... 04:23:23 INFO - Return code: 0 04:23:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:23:23 INFO - Using env: {'DISPLAY': ':0', 04:23:23 INFO - 'HOME': '/home/cltbld', 04:23:23 INFO - 'LANG': 'en_US.UTF-8', 04:23:23 INFO - 'LANGUAGE': 'en_US:en', 04:23:23 INFO - 'LOGNAME': 'cltbld', 04:23:23 INFO - 'MAIL': '/var/mail/cltbld', 04:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:23 INFO - 'MOZ_NO_REMOTE': '1', 04:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:23 INFO - 'NO_EM_RESTART': '1', 04:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:23 INFO - 'PWD': '/builds/slave/test', 04:23:23 INFO - 'SHELL': '/bin/bash', 04:23:23 INFO - 'SHLVL': '1', 04:23:23 INFO - 'TERM': 'linux', 04:23:23 INFO - 'TMOUT': '86400', 04:23:23 INFO - 'USER': 'cltbld', 04:23:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:23 INFO - '_': '/tools/buildbot/bin/python'} 04:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:23 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:23 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 04:23:23 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 04:23:23 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 04:23:23 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 04:23:23 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 04:23:23 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 04:23:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:25 INFO - warning: no files found matching '*.txt' 04:23:25 INFO - no previously-included directories found matching 'build' 04:23:25 INFO - no previously-included directories found matching 'dist' 04:23:25 INFO - no previously-included directories found matching '.git*' 04:23:25 INFO - Installing collected packages: jsonschema, functools32 04:23:25 INFO - Running setup.py install for functools32 04:23:25 INFO - warning: no files found matching '*.txt' 04:23:25 INFO - no previously-included directories found matching 'build' 04:23:25 INFO - no previously-included directories found matching 'dist' 04:23:25 INFO - no previously-included directories found matching '.git*' 04:23:25 INFO - Successfully installed jsonschema functools32 04:23:25 INFO - Cleaning up... 04:23:25 INFO - Return code: 0 04:23:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:25 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')]} 04:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 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')]} 04:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:25 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 04:23:25 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 04:23:25 INFO - Using env: {'DISPLAY': ':0', 04:23:25 INFO - 'HOME': '/home/cltbld', 04:23:25 INFO - 'LANG': 'en_US.UTF-8', 04:23:25 INFO - 'LANGUAGE': 'en_US:en', 04:23:25 INFO - 'LOGNAME': 'cltbld', 04:23:25 INFO - 'MAIL': '/var/mail/cltbld', 04:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:25 INFO - 'MOZ_NO_REMOTE': '1', 04:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:25 INFO - 'NO_EM_RESTART': '1', 04:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:25 INFO - 'PWD': '/builds/slave/test', 04:23:25 INFO - 'SHELL': '/bin/bash', 04:23:25 INFO - 'SHLVL': '1', 04:23:25 INFO - 'TERM': 'linux', 04:23:25 INFO - 'TMOUT': '86400', 04:23:25 INFO - 'USER': 'cltbld', 04:23:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:25 INFO - '_': '/tools/buildbot/bin/python'} 04:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:25 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 04:23:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:27 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 04:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:28 INFO - Downloading docopt-0.6.1.tar.gz 04:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:28 INFO - Running setup.py install for blobuploader 04:23:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:28 INFO - Running setup.py install for requests 04:23:29 INFO - Running setup.py install for docopt 04:23:29 INFO - Successfully installed blobuploader requests docopt 04:23:29 INFO - Cleaning up... 04:23:29 INFO - Return code: 0 04:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:29 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:29 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 04:23:29 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 04:23:29 INFO - Using env: {'DISPLAY': ':0', 04:23:29 INFO - 'HOME': '/home/cltbld', 04:23:29 INFO - 'LANG': 'en_US.UTF-8', 04:23:29 INFO - 'LANGUAGE': 'en_US:en', 04:23:29 INFO - 'LOGNAME': 'cltbld', 04:23:29 INFO - 'MAIL': '/var/mail/cltbld', 04:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:29 INFO - 'MOZ_NO_REMOTE': '1', 04:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:29 INFO - 'NO_EM_RESTART': '1', 04:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:29 INFO - 'PWD': '/builds/slave/test', 04:23:29 INFO - 'SHELL': '/bin/bash', 04:23:29 INFO - 'SHLVL': '1', 04:23:29 INFO - 'TERM': 'linux', 04:23:29 INFO - 'TMOUT': '86400', 04:23:29 INFO - 'USER': 'cltbld', 04:23:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:29 INFO - '_': '/tools/buildbot/bin/python'} 04:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:29 INFO - Running setup.py (path:/tmp/pip-OARczB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:29 INFO - Running setup.py (path:/tmp/pip-lWrrpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:29 INFO - Running setup.py (path:/tmp/pip-xGh2RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:29 INFO - Running setup.py (path:/tmp/pip-UcUYI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:29 INFO - Running setup.py (path:/tmp/pip-qWuaja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:29 INFO - Running setup.py (path:/tmp/pip-KwdKW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:29 INFO - Running setup.py (path:/tmp/pip-At0xuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:29 INFO - Running setup.py (path:/tmp/pip-ADDRdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:29 INFO - Running setup.py (path:/tmp/pip-K3dHOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:30 INFO - Running setup.py (path:/tmp/pip-_VSI4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:30 INFO - Running setup.py (path:/tmp/pip-BpA13r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:30 INFO - Running setup.py (path:/tmp/pip-_d16Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:30 INFO - Running setup.py (path:/tmp/pip-4KMiU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:30 INFO - Running setup.py (path:/tmp/pip-A74yDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:30 INFO - Running setup.py (path:/tmp/pip-rHHwpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:30 INFO - Running setup.py (path:/tmp/pip-roYuQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:30 INFO - Running setup.py (path:/tmp/pip-MUCtGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:30 INFO - Running setup.py install for manifestparser 04:23:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:30 INFO - Running setup.py install for mozcrash 04:23:30 INFO - Running setup.py install for mozdebug 04:23:30 INFO - Running setup.py install for mozdevice 04:23:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozfile 04:23:31 INFO - Running setup.py install for mozhttpd 04:23:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozinfo 04:23:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozInstall 04:23:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozleak 04:23:31 INFO - Running setup.py install for mozlog 04:23:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for moznetwork 04:23:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozprocess 04:23:31 INFO - Running setup.py install for mozprofile 04:23:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:31 INFO - Running setup.py install for mozrunner 04:23:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozscreenshot 04:23:32 INFO - Running setup.py install for moztest 04:23:32 INFO - Running setup.py install for mozversion 04:23:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:32 INFO - Cleaning up... 04:23:32 INFO - Return code: 0 04:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:32 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')]} 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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')]} 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:32 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 04:23:32 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 04:23:32 INFO - Using env: {'DISPLAY': ':0', 04:23:32 INFO - 'HOME': '/home/cltbld', 04:23:32 INFO - 'LANG': 'en_US.UTF-8', 04:23:32 INFO - 'LANGUAGE': 'en_US:en', 04:23:32 INFO - 'LOGNAME': 'cltbld', 04:23:32 INFO - 'MAIL': '/var/mail/cltbld', 04:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:32 INFO - 'MOZ_NO_REMOTE': '1', 04:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:32 INFO - 'NO_EM_RESTART': '1', 04:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:32 INFO - 'PWD': '/builds/slave/test', 04:23:32 INFO - 'SHELL': '/bin/bash', 04:23:32 INFO - 'SHLVL': '1', 04:23:32 INFO - 'TERM': 'linux', 04:23:32 INFO - 'TMOUT': '86400', 04:23:32 INFO - 'USER': 'cltbld', 04:23:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:32 INFO - '_': '/tools/buildbot/bin/python'} 04:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:32 INFO - Running setup.py (path:/tmp/pip-79X7gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:32 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)) 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:32 INFO - Running setup.py (path:/tmp/pip-TKYk3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:32 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)) 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:32 INFO - Running setup.py (path:/tmp/pip-v_ZQwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:32 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)) 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:32 INFO - Running setup.py (path:/tmp/pip-srEwdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:32 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)) 04:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:32 INFO - Running setup.py (path:/tmp/pip-xv6yoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:33 INFO - Running setup.py (path:/tmp/pip-EE0S3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:33 INFO - Running setup.py (path:/tmp/pip-FOsVIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:33 INFO - Running setup.py (path:/tmp/pip-Y9pRa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:33 INFO - Running setup.py (path:/tmp/pip-uNakO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:33 INFO - Running setup.py (path:/tmp/pip-Vs6GPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:33 INFO - Running setup.py (path:/tmp/pip-ZenMWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:33 INFO - Running setup.py (path:/tmp/pip-zfHwed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:33 INFO - Running setup.py (path:/tmp/pip-uAXHyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:33 INFO - Running setup.py (path:/tmp/pip-7nkyEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:33 INFO - Running setup.py (path:/tmp/pip-Cw1498-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:33 INFO - Running setup.py (path:/tmp/pip-CIpk4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:33 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)) 04:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:33 INFO - Running setup.py (path:/tmp/pip-G802GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:33 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)) 04:23:33 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)) 04:23:33 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)) 04:23:33 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)) 04:23:33 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)) 04:23:33 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)) 04:23:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:33 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 04:23:33 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 04:23:33 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 04:23:33 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 04:23:33 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 04:23:33 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 04:23:35 INFO - Downloading blessings-1.6.tar.gz 04:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:35 INFO - Installing collected packages: blessings 04:23:35 INFO - Running setup.py install for blessings 04:23:36 INFO - Successfully installed blessings 04:23:36 INFO - Cleaning up... 04:23:36 INFO - Return code: 0 04:23:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:36 INFO - Reading from file tmpfile_stdout 04:23:36 INFO - Current package versions: 04:23:36 INFO - argparse == 1.2.1 04:23:36 INFO - blessings == 1.6 04:23:36 INFO - blobuploader == 1.2.4 04:23:36 INFO - docopt == 0.6.1 04:23:36 INFO - functools32 == 3.2.3-2 04:23:36 INFO - jsonschema == 2.5.1 04:23:36 INFO - manifestparser == 1.1 04:23:36 INFO - mozInstall == 1.12 04:23:36 INFO - mozcrash == 0.17 04:23:36 INFO - mozdebug == 0.1 04:23:36 INFO - mozdevice == 0.48 04:23:36 INFO - mozfile == 1.2 04:23:36 INFO - mozhttpd == 0.7 04:23:36 INFO - mozinfo == 0.9 04:23:36 INFO - mozleak == 0.1 04:23:36 INFO - mozlog == 3.2 04:23:36 INFO - moznetwork == 0.27 04:23:36 INFO - mozprocess == 0.23 04:23:36 INFO - mozprofile == 0.28 04:23:36 INFO - mozrunner == 6.12 04:23:36 INFO - mozscreenshot == 0.1 04:23:36 INFO - mozsystemmonitor == 0.3 04:23:36 INFO - moztest == 0.7 04:23:36 INFO - mozversion == 1.4 04:23:36 INFO - psutil == 3.1.1 04:23:36 INFO - requests == 1.2.3 04:23:36 INFO - wsgiref == 0.1.2 04:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:36 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 04:23:36 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 04:23:36 INFO - Using env: {'DISPLAY': ':0', 04:23:36 INFO - 'HOME': '/home/cltbld', 04:23:36 INFO - 'LANG': 'en_US.UTF-8', 04:23:36 INFO - 'LANGUAGE': 'en_US:en', 04:23:36 INFO - 'LOGNAME': 'cltbld', 04:23:36 INFO - 'MAIL': '/var/mail/cltbld', 04:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:36 INFO - 'MOZ_NO_REMOTE': '1', 04:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:36 INFO - 'NO_EM_RESTART': '1', 04:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:36 INFO - 'PWD': '/builds/slave/test', 04:23:36 INFO - 'SHELL': '/bin/bash', 04:23:36 INFO - 'SHLVL': '1', 04:23:36 INFO - 'TERM': 'linux', 04:23:36 INFO - 'TMOUT': '86400', 04:23:36 INFO - 'USER': 'cltbld', 04:23:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:36 INFO - '_': '/tools/buildbot/bin/python'} 04:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 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)) 04:23:36 INFO - Cleaning up... 04:23:36 INFO - Return code: 0 04:23:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:36 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 04:23:36 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 04:23:36 INFO - Using env: {'DISPLAY': ':0', 04:23:36 INFO - 'HOME': '/home/cltbld', 04:23:36 INFO - 'LANG': 'en_US.UTF-8', 04:23:36 INFO - 'LANGUAGE': 'en_US:en', 04:23:36 INFO - 'LOGNAME': 'cltbld', 04:23:36 INFO - 'MAIL': '/var/mail/cltbld', 04:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:36 INFO - 'MOZ_NO_REMOTE': '1', 04:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:36 INFO - 'NO_EM_RESTART': '1', 04:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:36 INFO - 'PWD': '/builds/slave/test', 04:23:36 INFO - 'SHELL': '/bin/bash', 04:23:36 INFO - 'SHLVL': '1', 04:23:36 INFO - 'TERM': 'linux', 04:23:36 INFO - 'TMOUT': '86400', 04:23:36 INFO - 'USER': 'cltbld', 04:23:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:36 INFO - '_': '/tools/buildbot/bin/python'} 04:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:36 INFO - Cleaning up... 04:23:36 INFO - Return code: 0 04:23:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:36 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 0x7f2a05e7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', '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 04:23:36 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 04:23:36 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 04:23:36 INFO - Using env: {'DISPLAY': ':0', 04:23:36 INFO - 'HOME': '/home/cltbld', 04:23:36 INFO - 'LANG': 'en_US.UTF-8', 04:23:36 INFO - 'LANGUAGE': 'en_US:en', 04:23:36 INFO - 'LOGNAME': 'cltbld', 04:23:36 INFO - 'MAIL': '/var/mail/cltbld', 04:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:36 INFO - 'MOZ_NO_REMOTE': '1', 04:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:36 INFO - 'NO_EM_RESTART': '1', 04:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:36 INFO - 'PWD': '/builds/slave/test', 04:23:36 INFO - 'SHELL': '/bin/bash', 04:23:36 INFO - 'SHLVL': '1', 04:23:36 INFO - 'TERM': 'linux', 04:23:36 INFO - 'TMOUT': '86400', 04:23:36 INFO - 'USER': 'cltbld', 04:23:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:36 INFO - '_': '/tools/buildbot/bin/python'} 04:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:36 INFO - Downloading/unpacking flake8 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:38 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 04:23:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:39 INFO - no previously-included directories found matching 'docs/_build' 04:23:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:39 INFO - Running setup.py install for pep8 04:23:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:39 INFO - no previously-included directories found matching 'docs/_build' 04:23:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:39 INFO - Cleaning up... 04:23:39 INFO - Return code: 0 04:23:39 INFO - Running post-action listener: _resource_record_post_action 04:23:39 INFO - Running post-action listener: _start_resource_monitoring 04:23:39 INFO - Starting resource monitoring. 04:23:39 INFO - ##### 04:23:39 INFO - ##### Finished create-virtualenv step (success) 04:23:39 INFO - ##### 04:23:39 INFO - ##### 04:23:39 INFO - ##### Running install step. 04:23:39 INFO - ##### 04:23:39 INFO - Running pre-action listener: _resource_record_pre_action 04:23:39 INFO - Running main action method: install 04:23:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:40 INFO - Reading from file tmpfile_stdout 04:23:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:40 INFO - Reading from file tmpfile_stdout 04:23:40 INFO - Output received: 04:23:40 INFO - Usage: mozinstall [options] installer 04:23:40 INFO - Options: 04:23:40 INFO - -h, --help show this help message and exit 04:23:40 INFO - -d DEST, --destination=DEST 04:23:40 INFO - Directory to install application into. [default: 04:23:40 INFO - "/builds/slave/test"] 04:23:40 INFO - --app=APP Application being installed. [default: firefox] 04:23:40 INFO - mkdir: /builds/slave/test/build/application 04:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:56 INFO - Reading from file tmpfile_stdout 04:23:56 INFO - Output received: 04:23:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:56 INFO - Running post-action listener: _resource_record_post_action 04:23:56 INFO - ##### 04:23:56 INFO - ##### Finished install step (success) 04:23:56 INFO - ##### 04:23:56 INFO - ##### 04:23:56 INFO - ##### Running run-tests step. 04:23:56 INFO - ##### 04:23:56 INFO - Running pre-action listener: _resource_record_pre_action 04:23:56 INFO - Running main action method: run_tests 04:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:56 INFO - Python 2.7.3 04:23:56 INFO - Return code: 0 04:23:56 INFO - grabbing minidump binary from tooltool 04:23:56 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')]} 04:23:56 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 0x25bb1c0>, '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 0x25bc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:56 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 04:23:56 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 04:23:56 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 04:23:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:56 INFO - Return code: 0 04:23:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:57 INFO - Return code: 0 04:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469618579.570666-717006436', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:23:57 INFO - mozversion application_buildid: 20160726081123 04:23:57 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:23:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:23:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:57 INFO - mozversion application_name: Firefox 04:23:57 INFO - mozversion application_remotingname: firefox-dev 04:23:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:23:57 INFO - mozversion application_vendor: Mozilla 04:23:57 INFO - mozversion application_version: 49.0a2 04:23:57 INFO - mozversion platform_buildid: 20160726081123 04:23:57 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:23:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:23:57 INFO - mozversion platform_version: 49.0a2 04:23:57 INFO - using testdate: 1469618637 04:23:57 INFO - actual date: 1469618637 04:23:57 INFO - starting webserver on 'localhost:50636' 04:23:57 INFO - SUITE-START | Running 2 tests 04:23:57 INFO - TEST-START | dromaeo_css 04:23:57 INFO - operating with platform_type : linux_ 04:23:57 INFO - Initialising browser for dromaeo_css test... 04:23:57 INFO - TEST-INFO | started process 9434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5GR7m/profile http://localhost:50636/getInfo.html) 04:24:01 INFO - PROCESS | 9434 | __metrics Screen width/height:1600/1200 04:24:01 INFO - PROCESS | 9434 | colorDepth:24 04:24:01 INFO - PROCESS | 9434 | Browser inner width/height: 1024/697 04:24:01 INFO - PROCESS | 9434 | __metrics 04:24:02 ERROR - PROCESS | 9434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:24:03 INFO - TEST-INFO | 9434: exit 0 04:24:03 INFO - Browser initialized. 04:24:03 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:03 INFO - TEST-INFO | started process 9564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5GR7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:15 INFO - PROCESS | 9564 | RSS: Main: 155885568 04:24:15 INFO - PROCESS | 9564 | 04:25:04 INFO - PROCESS | 9564 | 1469618704632 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] 04:27:12 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50636/tests/dromaeo/cssquery-ext.html) 04:27:13 INFO - PROCESS | 9564 | RSS: Main: 160382976 04:27:13 INFO - PROCESS | 9564 | 04:30:15 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-ext.html (next: http://localhost:50636/tests/dromaeo/cssquery-jquery.html) 04:30:16 INFO - PROCESS | 9564 | RSS: Main: 157847552 04:30:16 INFO - PROCESS | 9564 | 04:33:18 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50636/tests/dromaeo/cssquery-mootools.html) 04:33:18 INFO - PROCESS | 9564 | RSS: Main: 157523968 04:33:18 INFO - PROCESS | 9564 | 04:36:20 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50636/tests/dromaeo/cssquery-prototype.html) 04:36:21 INFO - PROCESS | 9564 | RSS: Main: 157188096 04:36:21 INFO - PROCESS | 9564 | 04:39:23 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50636/tests/dromaeo/cssquery-yui.html) 04:39:24 INFO - PROCESS | 9564 | RSS: Main: 159567872 04:39:24 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | Cycle 1(1): loaded http://localhost:50636/tests/dromaeo/cssquery-yui.html (next: http://localhost:50636/tests/dromaeo/cssquery-dojo.html) 04:42:26 INFO - PROCESS | 9564 | RSS: Main: 159559680 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | __start_tp_report 04:42:26 INFO - PROCESS | 9564 | _x_x_mozilla_page_load 04:42:26 INFO - PROCESS | 9564 | _x_x_mozilla_page_load_details 04:42:26 INFO - PROCESS | 9564 | |i|pagename|runs| 04:42:26 INFO - PROCESS | 9564 | |0;dojo.html;3376.358491886543;3388.5256064151017;3419.452887537994;3444.7416443766706;3445.9827700861506;5603.87922415517;5635.492805647491;5665.036943719567;5695.544356451484;5763.567732420064;5690.971545142268;5722.456366645162;5756.3092428908585;5757.654540727559;5762.250907382045;5164.92252616211;5224.895502089956;5266.368035835686;5299.814506492274;5323.041852466555;5165.354330708661;5169.457206993268;5313.149896016638;5314.495122963332;5316.813911513098;5228.268042474037;5253.448387919251;5254.474552544753;5277.656952298088;5281.735913204344;5272.23552584875;5310.097283461821;5324.281222035033;5328.49379308965;5334.759935802898;5050.570701490377;5165.638405311592;5225.372955245357;5256.421793602701;5256.474352564751;5510.421405752419;5510.559155267569;5551.000819852425;5597.3003374578175;5612.298462692163;6098.32918378978;6108.602940808833;6130.724117414727;6149.385061493815;6168.228971378578;5956.047032474827;6075.787347442818;6206.627602343874;6216.564840461169;6217.56477046607;5686.2607860977805;5751.309842818889;5754.827355179351;5783.045797443417;5811.15738217956;6290.779822706183;6296.244450665858;6299.842503937347;6323.43089121972;6333.936660633427;5846.327672317738;6054.8183554493435;6059.182010428536;6072.635641861502;6115.235595550556;6179.660118693515;6194.34959329273;6195.039768835748;6200.038993955944;6210.347913469111;6107.938920610826;6127.387261273837;6151.753929842756;6159.137720719103;6191.938080619136;5980.790672326448;6081.057436097412;6111.633302001894;6112.716259964451;6160.507159427235;4737.526247375235;4739.644526660514;4741.95258047422;4768.856934291976;4782.569568738761;4224.78876056196;4239.554846741048;4241.448611680462;4247.426597409372;4270.765107919032;5688.431156884361;5864.67744274069;5897.439743224387;5915.349311575723;5915.526757859447;6116.785912493041;6124.234470691164;6134.018557030854;6179.938200618026;6211.440970312603;5787.681677507778;5961.970190149022;5967.5524335675;5976.701164941735;5996.580239383288;5294.047071527162;5311.681299122065;5322.3879253885525;5360.812371566976;5390.137577987503;6427.357264273535;6459.257185423737;6486.351364863476;6488.221413430419;6490.513211509061;5922.378150294329;6106.145139680537;6237.282712488122;6240.251169859646;6254.4996400286955;6311.589746666452;6415.582987105823;6435.742570297136;6453.9354606453335;6467.708953097216;6018.398160183947;6044.516438684983;6045.939540604713;6062.757489700362;6066.636001839904;6018.217631708025;6118.60229085108;6126.754929802936;6148.78479253224;6191.349908259568;6058;6097.5426842987845;6103.816885493442;6117.082437634391;6132.601380910227;6053.364396738279;6060.333363330118;6066.15073889647;6072.635641861502;6079.422454866781;5561.4716601922755;5829.446202610745;5900.055991041413;5906.055031194988;5958.702064896825;6025.337212906489;6031.4270144336215;6040.879182416415;6042.909356359746;6071.362506936708;5972;5976.252968378953;5979.970100149471;5985.102234664835;5999.4900433463645 04:42:26 INFO - PROCESS | 9564 | |1;ext.html;608.6013661052012;651.7425616881332;658.2495954611743;682.1507223506733;682.3722175598449;42231.15537689248;46001;46041.53958460423;46234.768826155865;46368.30447543285;46385.30422043672;46972;47001.764991175;47019;47028;8917.554122293892;9082.13719696631;9088.727338179866;9092.954535227347;9140.131687489678;9034.86447703285;9126.315526335551;9138.360314777969;9143.268538516935;9158.86261706075;9148.72553823383;9170.954145229265;9174.678886238982;9175;9199.356045076847;9109.863352049724;9109.954450227773;9116.453012819253;9144.4970526621;9153.450792952377;9046.321525885585;9115;9132;9132.771680708036;9136.497492637902;43396.566034339885;43644.908877278;43762.34356484655;43790.56209437897;43819.56180438187;3824.158685089276;3917.251775159663;4396.868093957187;4425.048614547888;4509.120721459317;34522;34571.481427778606;35123.824380878184;35187.824060879786;36144.27711445783;4745.39964000416;4758.452777930513;4791.904161916777;4805.831795887128;4865.2945322928335;262395;263325;263471.6826415875;263980;264470;34592.308153837286;64977.35022649713;65989;66012.66993665001;66083.33916660868;41498.79250603728;41587.37618935719;41674;41706.165876682295;41711.582884171374;17486.47540573785;17702.203400846993;17706.91146544259;17720;17747.73378399325;12941.741165176833;12973.481060757464;13046.804297935538;13108.082434229704;13123.212607243597;9215.769605759775;9241.861372079424;9242.722718318326;9293.442393456278;9342.299327550461;3521.7182625389905;3546.680798728127;3564.4118720410843;3597.586277578112;3618.5295911531857;1073.7906108308962;1111.955521779136;1114.2478826791883;1181.5037684172669;1226.3745489800267;34263.143421414665;34629.13427164341;34808;34947;35436;1173.8650055243586;1213.7754515414676;1227.735432504504;1256.466001949168;1350.3113412159869;17750;18039.909800451176;18044.458666240032;18168.182431790337;18360.632787344177;608916;611079;612255;614241;617269;66624;67142.32857671361;67320.6633966827;67389.66305168443;67428;1462.56854228003;1487.5983484459352;1488.6724920517686;1518.627936155649;1522.5356266338651;32597;32962.34075318528;33103.33793324072;33266.66733332733;33763;56846;56888;57268.42731572631;57498.42501574931;57764;465253;465445;465872;466634;467653;30954.845225773726;31144;31157.53263701001;31172.68827311698;31323;52605;52825.471745282055;53989.73005134949;54054;54700.726496367264;45644.31533526933;46268.305975411065;46384.53615463802;46424.53575464202;47068.7646561765;44780.77609611931;45232;45627;46257;46888;40814.183716324915;44383.33424998563;45135.54864451445;46271.53728462672;48224.276635851194;39293.41059884161;39851.40222896717;39907.60092399039;39919;39968.60031399649;29589.408211835213;30109.247268818453;30428.391432171677;30441.543376848924;30577 04:42:26 INFO - PROCESS | 9564 | |2;jquery.html;429.0303913156266;430.35876543949513;430.5758827554859;430.81905599648144;447.3178402935523;18422.723659145107;19443.708344374827;20062.197512099516;20815.27146549871;20871.165153393846;19797.847607433763;20302.69545956808;20592.897035514838;20898.37304880856;20910.581788364223;5651.2935883014525;5877.089051197071;5893.233879595647;5918;5926.822195334147;5611.7474713637985;5726.3987281335485;5784.739686714087;5802.332731735863;5809.7676092956235;5716.857078573048;5727.599068065237;5753.568482363839;5765.394633563478;5778.24882765242;5544.695041772701;5580.720963951807;5597.216389705465;5625.240592519998;5633.070543360341;5021.748912554358;5033.370828646419;5041;5052.317937078484;5062.392512898476;22746.772532274797;23529;23814.404639883967;23843;23900.641490377657;2713.592961055838;2721.700612932576;2728.4133911208987;2769.418422131355;2824.5057115004793;14402.567922962224;15113.773293400498;15433.074015559103;15456.845431545653;15477.148756818371;1984.9233687783876;1987.6124155789628;2002.019010684754;2070.513429344103;2129.4463439505685;81338;82914;83206;83337.58331208366;83361.58319208426;11104.500297486633;11160.720981975353;11448.141389395829;11450;11592.1305902056;15885.444009459614;15888;15910.284037218353;15985.840141598668;15990.920045399698;8573.957130214309;8679.91320086791;8801.295896328407;8828.42615230008;8860.778480538038;8390.077091519928;8477.321814254845;8621.66364213548;8683.522406267715;8772.868406973901;6884.690188941509;6933.687984040629;7020.016492990459;7111.502194846415;7175.210726820045;1839.7424360589528;2002.5294055896852;2057.6399130152463;2079.0913083403407;2091.4771307173205;986.40815510693;1096.7098703888335;1116.4752566293828;1123.3035517978906;1156.8206927926185;19410.611787764166;20201.898990505248;20331.695024574645;20718.48203794887;20781.792182078287;1116.4083035990939;1126.814075677504;1134.8127558952845;1155.7919574476507;1184.7571247894161;11063.170262230366;11543.480543375568;11634.069274458023;11776.11679124069;11880.76238475243;555274;557806;561120;569318;575409;80303;84122;85096.57451712702;86117.56941215254;86437;1128.8758236593967;1138.6014894786758;1147.6729132197283;1165.0330225912471;1179.2334982261427;17376.652466950844;17808.55478612993;18131;18313.633727325112;18414.17136228846;39716.80141599273;41011.7949410251;44086;44339;44972.55027449683;57774.42225577858;57895;57959.13061304;58965;60029.69985150046;6743.561668491532;7843.294103530709;8688.91311086881;9115.817683646157;9374;9657.806843863224;12466.376681166086;12519.812202817147;12559.43482543306;12587.370631468573;11032.227744057838;11171.21801473889;11285.830712539155;11337.603183888854;11374.488148033524;10643.627473038407;10659.4137322448;10787.67636970892;10800.945995269973;11148;10834.295770774874;10967.122630189406;11164.72088197769;11231.494582743633;11327.847708935276;8756.080611535952;8825.117488251124;8964.506952117696;8989.235914947041;9093.4998575079;10803.081738052353;10973.23187376876;11063.170262230204;11155.944220278847;11194.328340299608 04:42:26 INFO - PROCESS | 9564 | |3;mootools.html;1600.8559229669331;1606.2290100751638;1826.8629852761046;1886;1910.4173227165718;8627.309815214783;9270.768230794225;9456.432614043162;9989.100980911726;9992.900070999287;9504.477253751042;9799.314048016642;9806.21550275978;9926.950365248164;9939.552720127593;2495.114234446768;2523.3691577105724;2523.73500782418;2526.6589010483626;2526.759957804006;2218.567379361017;2292.2893902890073;2295.735990361105;2299.7700229976954;2303.735070466901;2491.489244704831;2515.295717199187;2528.05198050731;2528.1657053172503;2532.2656429635385;2515.220281712675;2516.949661006788;2520.5211009908057;2534.581794003987;2553.182981445938;2513.17065368428;2539.149384956042;2556.3864672478658;2581.083715281067;2585.108137692493;9611.990740972167;9628.614855405775;9686.370385924964;9704.854427183598;9735.075167859042;5565.526930210937;5925.644461332291;5983.820485385445;5991.430814072656;6010.128531362928;3651.3062518121737;3744.8689295874515;3766.0961369271454;3792.317382871082;3869.6323849234277;1132.6149109302876;1155.2086820527966;1159.7390587117916;1171.2094336322948;1183.4615250061202;14036.649083772885;14040.087394319438;14043.22762248076;14046.297685115704;14078.084924479876;5165.845024649267;5201.45384734605;5206.55744261742;5250.398628418369;5257.605679574047;11607.30356178632;11648.242864213798;11688.590899318484;11703.707407314714;11719.765604687858;6004.54965877561;6011.248593925759;6014.067819487899;6037.728302226323;6068.393160683984;4872.074305881871;5332;5443.836684899459;5498.5876059295715;5498.917516237259;4424.446944131983;4463.575960283768;4506.842260520932;4527.592516673515;4531.84138555149;1399.803168291117;1403.5999740074235;1422.4807945099965;1424.287856071964;1436.899417040797;968.1722127580957;1063.4310643805527;1066.8399740038901;1083.4853444613746;1096.6490722968574;6551;6615.966920165464;6685.899711504331;6701.865962680817;6754.200789503862;495.2027236149796;500.56951022120944;504.0523815227349;513.3121617033194;513.5301199402505;4573.885652858638;4581.656375771764;4629.65277604181;4630.930536041962;4636.11913736389;12061.939690301493;12482.563110291096;12563.623091307092;12600.306983116017;12616.81074783879;11680;12094.637160885188;12100.33448160342;12434;12487.375631218403;9034.412763170372;9084.273258139334;9116.361854670242;9142.222911052502;9203.861942070875;6639.601623902581;6780.694868731018;6831.157424042768;6836.863262734817;7006.194287656985;11284.492197851281;11469.426528673699;11479.885201147881;11554.653360399201;11681.415929203336;11552.480138393625;11739.941300293785;11749.412529373669;11831.40842957866;11908.940455297668;7898.328642065489;8511.74464766058;8789.121087891159;8815.867761983704;8955.731328060168;9791.46146961924;9794.510274486105;9828.361156524803;9910.801783964425;9931.900680993098;8399.202075802788;8407.579621018802;8476.194761497647;8605.784855378666;8832.5583720815;7993.280604745601;8003.679852806055;8226.629801659059;8436;8439.029511606244;7530.28462296081;7754.457187996786;7758.185390534139;7907.8813817793925;7908.130105688485;5698.572607054571;5761.251037365116;5820.854478638068;5864.501517371071;5875.882482350415;5706.80026199081;5718.1708652246025;5745.368009519033;5846.970765146147;5891.1457838612305 04:42:26 INFO - PROCESS | 9564 | |4;prototype.html;352.89413176047185;356.41903696973935;359.89023347878884;360.06024276637953;363.521968611276;5681.460261275178;5692.544596432286;5698.857528561788;5718.9428105718935;5770.076787713967;5571.832845014656;5594.356648985368;5625.774969001235;5636.887262254752;5655.010373184687;4260.446142001535;4391.692581519295;4404.14119246747;4404.427424434835;4410.580994805505;4355;4412;4413.845515406962;4429.379886815832;4432.135733531963;4372.300431930892;4389.758563279034;4391.429114215163;4404.383386325917;4405.757683327416;4166.64583510402;4354.6516278697945;4376;4382.934255986131;4447.911041779163;3835.3863381859046;3837.270918525499;3841.9423708644395;3845.442410850411;3853.2486165197797;5369.275147855029;5447.6459030163305;5448.318960129984;5457.972710136463;5513.42109078549;4905.4358748744;4947.431045429786;4954.801807927714;5006.799728010875;5025.3718285214345;5881.79413720522;5883.676172861072;5899.675517846516;5922.2597175353085;5994.520438364921;4237.4915010198665;4253.1706317268145;4283.164782867342;4284.892877678052;4294.3558466230315;5879.2944846618675;6003.699815009276;6032.607880487754;6150.9245377311345;6152.24450338346;4278.4865816102265;4285.935710964338;4297.957020429756;4302.139572085595;4314.115606300701;4359.694821362475;4366.279563871989;4369.80335884886;4388.758618275961;4396.626286765661;4899.461059283476;4968.850934471971;5014.423341315723;5024.120778863758;5036.32009678696;5865.20819689345;5909.8227053188475;5909.847579721913;5917.201177841022;5957.791477298274;1464.4288727396324;1502.5642563656418;1514.8409417011276;1520.049968769519;1521.8325984141736;941.3363578677016;960.8750862387984;969.5685419988179;971.1939090554822;983.9754006149903;5066.9478861061325;5101.51535604117;5156.896862062813;5182.564194828425;5227.3465816772905;5413.404525502192;5442.394493624391;5485.835424937259;5497.752601132958;5505.256790333254;4867.610591152699;5031.245313203049;5052.949470505321;5169.560587350042;5234.293370395024;2863.053123875743;2871.2821794551364;2906.941861162807;2915.090615646755;2936.779741519352;5459.669601543055;5506.229127922094;5517.813670060957;5527.861803454865;5555.972220138954;5176.663516871391;5423.810166644149;5430.723779911717;5445.673259604358;5448;5542.61201715876;5568.470995255444;5595.496405323622;5611.569049892251;5630.451625802855;5278.205410160564;5328.66783304174;5339.626226164131;5418.83743487696;5798.59409841307;6010.789622363196;6080.543959202989;6085.543584231289;6097.420745029215;6113.5414843886;6180.227471566054;6385.744570217139;6393.456556192776;6414.134091897721;6429.871402571829;4348.7390756554705;4386.188555117314;4398.516163221979;4400.207962566768;4406.272964960745;6000.279966404059;6112.449879510866;6117.663528505975;6166.828302622487;6280.7487700491465;5948.702564871825;5950.642961422329;5951.851203719769;5981.880362392815;6000.339962604197;6006.819795406145;6020.608660437058;6034.370719905689;6042.395760424099;6081.726322315418;5637.3235211774845;5911.438413350725;5923.614965027259;5945.554083443672;5968.522518198447;5979.760809567569;6034.185384972972;6104.26748790148;6107.236595425572;6108.541859360477;5631.324241091095;5828.213191219131;5885.14665373527;5963.671998040149;5985.40145985398 04:42:26 INFO - PROCESS | 9564 | |5;yui.html;793.8848866914298;819.5533434278318;850.5194565070735;873.7029410000598;923.1783712495876;14562.417503299868;15007.699846003074;15820.20898955052;15824.604384890383;15856.84143158568;15789.526314210592;15825.208739563033;15883.841161588382;15959.361625534993;15965.361385544564;857.5755001274363;882.9470231786113;887.6671248281895;889.8042430665244;893.5889490834192;880.7842078690729;886.0784783824814;887.8490656588395;889.2263730554427;890.2699786175307;925.4077390470104;925.7870689741363;926.3561824531953;927.9257659387266;929.2751653710117;919.2508105893676;919.935604507688;920.9309301802392;921.1617428140394;922.8062106957547;674.1202730436778;674.4840197249108;675.2841987493224;677.1028387386732;678.8879834827247;16641.583960400967;16672.74990875138;16750.16249187536;16786.74819877703;16809.66380672392;13898;14857.925710371486;15093.39626414942;15150.393984240618;15300.617484562863;14004.29978501071;14230.928845355811;14265.91765880406;14290.64273393163;14323;4737.407824021997;4744.691595046311;4757.381540399726;4927.039227350668;4940.530649588283;80033.59983200047;80958;81626;81626.59186704087;82527.17472825314;12138.08964327679;12145.514179432901;12293.56972505958;12348.938255308845;12369.62891113268;21364.679529807065;21377.89311053466;21505.24731634385;21680;21687.457813554473;8433.662653493915;8470.364722645827;8475.872861907077;8498.74503764888;8600.440971336842;4950.4059512858685;5030.84907452777;5062.873428164326;5077.26379674945;5194.740262986836;3616.9819150904605;3670.6879915207505;3720.8511659533856;3727.3849814780256;3729.9067523312133;677.190757045336;685.2462291479333;687.9174499060144;695.1449716848305;699.105145413871;632.9651869147241;699.5942353434996;727.7452891488043;732.2677322677323;742.417202496038;8933.419327743806;9121.771955701028;9207.669414260734;9279.350445468752;9398;616.7810427298334;656.2715385921623;724.5616402076773;771.8417724366492;778;4302.182585308781;4372.3878656988045;4537.886552836206;4614.341766076729;4653.930191047137;73158.26841731515;73360.26639733535;73410.2658973414;84811.57594211989;93328.53335733278;63117.68441157765;64977.67511162508;92483.53758231166;95265;97819;83593.16406835854;85183.14816851876;85500.57249713836;87634;87995.56002219948;8157.184281572033;8258.587070646563;8316.62575184106;8383.916160838313;8506.234438900281;53125.46874531205;53143.73428132989;53617.46382536125;53843;54033.18950215828;71579;75068.62465687636;76220;76289;78693.60653196697;12267.938660306998;12463.626091217278;12483.56307529232;12566.748665026465;12739.171953822972;12561.623151305475;12621.286870463153;13218.272994985367;13478.52825151115;13669.521566745116;12472.563460278847;12490.687732806753;12602;12863;13069.15050521713;12560.685982850502;12714.61856144317;13176;13188.472461101832;14551.563453096423;14573.854261457675;14772.261386930395;14860.479883204036;15343.23283835826;15599.766003510184;11279.7744045117;11376.658700239006;11786.351750653454;11978.76042479163;12349.32078735678;12124.211926224767;12131.878681213428;13133.277669728257;13150.539731109366;13437.193768373929 04:42:26 INFO - PROCESS | 9564 | __end_tp_report 04:42:26 INFO - PROCESS | 9564 | __start_cc_report 04:42:26 INFO - PROCESS | 9564 | _x_x_mozilla_cycle_collect,337 04:42:26 INFO - PROCESS | 9564 | __end_cc_report 04:42:26 INFO - PROCESS | 9564 | __startTimestamp1469619746682__endTimestamp 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | ------- Summary: start ------- 04:42:26 INFO - PROCESS | 9564 | Number of tests: 6 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#0] dojo.html Cycles:165 Average:5726.25 Median:5976.25 stddev:637.59 (10.7%) stddev-sans-first:612.31 04:42:26 INFO - PROCESS | 9564 | Values: 3376.4 3388.5 3419.5 3444.7 3446.0 5603.9 5635.5 5665.0 5695.5 5763.6 5691.0 5722.5 5756.3 5757.7 5762.3 5164.9 5224.9 5266.4 5299.8 5323.0 5165.4 5169.5 5313.1 5314.5 5316.8 5228.3 5253.4 5254.5 5277.7 5281.7 5272.2 5310.1 5324.3 5328.5 5334.8 5050.6 5165.6 5225.4 5256.4 5256.5 5510.4 5510.6 5551.0 5597.3 5612.3 6098.3 6108.6 6130.7 6149.4 6168.2 5956.0 6075.8 6206.6 6216.6 6217.6 5686.3 5751.3 5754.8 5783.0 5811.2 6290.8 6296.2 6299.8 6323.4 6333.9 5846.3 6054.8 6059.2 6072.6 6115.2 6179.7 6194.3 6195.0 6200.0 6210.3 6107.9 6127.4 6151.8 6159.1 6191.9 5980.8 6081.1 6111.6 6112.7 6160.5 4737.5 4739.6 4742.0 4768.9 4782.6 4224.8 4239.6 4241.4 4247.4 4270.8 5688.4 5864.7 5897.4 5915.3 5915.5 6116.8 6124.2 6134.0 6179.9 6211.4 5787.7 5962.0 5967.6 5976.7 5996.6 5294.0 5311.7 5322.4 5360.8 5390.1 6427.4 6459.3 6486.4 6488.2 6490.5 5922.4 6106.1 6237.3 6240.3 6254.5 6311.6 6415.6 6435.7 6453.9 6467.7 6018.4 6044.5 6045.9 6062.8 6066.6 6018.2 6118.6 6126.8 6148.8 6191.3 6058.0 6097.5 6103.8 6117.1 6132.6 6053.4 6060.3 6066.2 6072.6 6079.4 5561.5 5829.4 5900.1 5906.1 5958.7 6025.3 6031.4 6040.9 6042.9 6071.4 5972.0 5976.3 5980.0 5985.1 5999.5 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#1] ext.html Cycles:180 Average:61658.47 Median:45183.77 stddev:125325.88 (277.4%) stddev-sans-first:125593.63 04:42:26 INFO - PROCESS | 9564 | Values: 608.6 651.7 658.2 682.2 682.4 42231.2 46001.0 46041.5 46234.8 46368.3 46385.3 46972.0 47001.8 47019.0 47028.0 8917.6 9082.1 9088.7 9093.0 9140.1 9034.9 9126.3 9138.4 9143.3 9158.9 9148.7 9171.0 9174.7 9175.0 9199.4 9109.9 9110.0 9116.5 9144.5 9153.5 9046.3 9115.0 9132.0 9132.8 9136.5 43396.6 43644.9 43762.3 43790.6 43819.6 3824.2 3917.3 4396.9 4425.0 4509.1 34522.0 34571.5 35123.8 35187.8 36144.3 4745.4 4758.5 4791.9 4805.8 4865.3 262395.0 263325.0 263471.7 263980.0 264470.0 34592.3 64977.4 65989.0 66012.7 66083.3 41498.8 41587.4 41674.0 41706.2 41711.6 17486.5 17702.2 17706.9 17720.0 17747.7 12941.7 12973.5 13046.8 13108.1 13123.2 9215.8 9241.9 9242.7 9293.4 9342.3 3521.7 3546.7 3564.4 3597.6 3618.5 1073.8 1112.0 1114.2 1181.5 1226.4 34263.1 34629.1 34808.0 34947.0 35436.0 1173.9 1213.8 1227.7 1256.5 1350.3 17750.0 18039.9 18044.5 18168.2 18360.6 608916.0 611079.0 612255.0 614241.0 617269.0 66624.0 67142.3 67320.7 67389.7 67428.0 1462.6 1487.6 1488.7 1518.6 1522.5 32597.0 32962.3 33103.3 33266.7 33763.0 56846.0 56888.0 57268.4 57498.4 57764.0 465253.0 465445.0 465872.0 466634.0 467653.0 30954.8 31144.0 31157.5 31172.7 31323.0 52605.0 52825.5 53989.7 54054.0 54700.7 45644.3 46268.3 46384.5 46424.5 47068.8 44780.8 45232.0 45627.0 46257.0 46888.0 40814.2 44383.3 45135.5 46271.5 48224.3 39293.4 39851.4 39907.6 39919.0 39968.6 29589.4 30109.2 30428.4 30441.5 30577.0 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#2] jquery.html Cycles:180 Average:31253.14 Median:23828.70 stddev:92455.74 (388.0%) stddev-sans-first:92686.14 04:42:26 INFO - PROCESS | 9564 | Values: 429.0 430.4 430.6 430.8 447.3 18422.7 19443.7 20062.2 20815.3 20871.2 19797.8 20302.7 20592.9 20898.4 20910.6 5651.3 5877.1 5893.2 5918.0 5926.8 5611.7 5726.4 5784.7 5802.3 5809.8 5716.9 5727.6 5753.6 5765.4 5778.2 5544.7 5580.7 5597.2 5625.2 5633.1 5021.7 5033.4 5041.0 5052.3 5062.4 22746.8 23529.0 23814.4 23843.0 23900.6 2713.6 2721.7 2728.4 2769.4 2824.5 14402.6 15113.8 15433.1 15456.8 15477.1 1984.9 1987.6 2002.0 2070.5 2129.4 81338.0 82914.0 83206.0 83337.6 83361.6 11104.5 11160.7 11448.1 11450.0 11592.1 15885.4 15888.0 15910.3 15985.8 15990.9 8574.0 8679.9 8801.3 8828.4 8860.8 8390.1 8477.3 8621.7 8683.5 8772.9 6884.7 6933.7 7020.0 7111.5 7175.2 1839.7 2002.5 2057.6 2079.1 2091.5 986.4 1096.7 1116.5 1123.3 1156.8 19410.6 20201.9 20331.7 20718.5 20781.8 1116.4 1126.8 1134.8 1155.8 1184.8 11063.2 11543.5 11634.1 11776.1 11880.8 555274.0 557806.0 561120.0 569318.0 575409.0 80303.0 84122.0 85096.6 86117.6 86437.0 1128.9 1138.6 1147.7 1165.0 1179.2 17376.7 17808.6 18131.0 18313.6 18414.2 39716.8 41011.8 44086.0 44339.0 44972.6 57774.4 57895.0 57959.1 58965.0 60029.7 6743.6 7843.3 8688.9 9115.8 9374.0 9657.8 12466.4 12519.8 12559.4 12587.4 11032.2 11171.2 11285.8 11337.6 11374.5 10643.6 10659.4 10787.7 10800.9 11148.0 10834.3 10967.1 11164.7 11231.5 11327.8 8756.1 8825.1 8964.5 8989.2 9093.5 10803.1 10973.2 11063.2 11155.9 11194.3 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#3] mootools.html Cycles:180 Average:6481.66 Median:497.89 stddev:3769.44 (757.1%) stddev-sans-first:3762.17 04:42:26 INFO - PROCESS | 9564 | Values: 1600.9 1606.2 1826.9 1886.0 1910.4 8627.3 9270.8 9456.4 9989.1 9992.9 9504.5 9799.3 9806.2 9927.0 9939.6 2495.1 2523.4 2523.7 2526.7 2526.8 2218.6 2292.3 2295.7 2299.8 2303.7 2491.5 2515.3 2528.1 2528.2 2532.3 2515.2 2516.9 2520.5 2534.6 2553.2 2513.2 2539.1 2556.4 2581.1 2585.1 9612.0 9628.6 9686.4 9704.9 9735.1 5565.5 5925.6 5983.8 5991.4 6010.1 3651.3 3744.9 3766.1 3792.3 3869.6 1132.6 1155.2 1159.7 1171.2 1183.5 14036.6 14040.1 14043.2 14046.3 14078.1 5165.8 5201.5 5206.6 5250.4 5257.6 11607.3 11648.2 11688.6 11703.7 11719.8 6004.5 6011.2 6014.1 6037.7 6068.4 4872.1 5332.0 5443.8 5498.6 5498.9 4424.4 4463.6 4506.8 4527.6 4531.8 1399.8 1403.6 1422.5 1424.3 1436.9 968.2 1063.4 1066.8 1083.5 1096.6 6551.0 6616.0 6685.9 6701.9 6754.2 495.2 500.6 504.1 513.3 513.5 4573.9 4581.7 4629.7 4630.9 4636.1 12061.9 12482.6 12563.6 12600.3 12616.8 11680.0 12094.6 12100.3 12434.0 12487.4 9034.4 9084.3 9116.4 9142.2 9203.9 6639.6 6780.7 6831.2 6836.9 7006.2 11284.5 11469.4 11479.9 11554.7 11681.4 11552.5 11739.9 11749.4 11831.4 11908.9 7898.3 8511.7 8789.1 8815.9 8955.7 9791.5 9794.5 9828.4 9910.8 9931.9 8399.2 8407.6 8476.2 8605.8 8832.6 7993.3 8003.7 8226.6 8436.0 8439.0 7530.3 7754.5 7758.2 7907.9 7908.1 5698.6 5761.3 5820.9 5864.5 5875.9 5706.8 5718.2 5745.4 5847.0 5891.1 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#4] prototype.html Cycles:180 Average:4861.54 Median:5446.66 stddev:1423.98 (26.1%) stddev-sans-first:1387.18 04:42:26 INFO - PROCESS | 9564 | Values: 352.9 356.4 359.9 360.1 363.5 5681.5 5692.5 5698.9 5718.9 5770.1 5571.8 5594.4 5625.8 5636.9 5655.0 4260.4 4391.7 4404.1 4404.4 4410.6 4355.0 4412.0 4413.8 4429.4 4432.1 4372.3 4389.8 4391.4 4404.4 4405.8 4166.6 4354.7 4376.0 4382.9 4447.9 3835.4 3837.3 3841.9 3845.4 3853.2 5369.3 5447.6 5448.3 5458.0 5513.4 4905.4 4947.4 4954.8 5006.8 5025.4 5881.8 5883.7 5899.7 5922.3 5994.5 4237.5 4253.2 4283.2 4284.9 4294.4 5879.3 6003.7 6032.6 6150.9 6152.2 4278.5 4285.9 4298.0 4302.1 4314.1 4359.7 4366.3 4369.8 4388.8 4396.6 4899.5 4968.9 5014.4 5024.1 5036.3 5865.2 5909.8 5909.8 5917.2 5957.8 1464.4 1502.6 1514.8 1520.0 1521.8 941.3 960.9 969.6 971.2 984.0 5066.9 5101.5 5156.9 5182.6 5227.3 5413.4 5442.4 5485.8 5497.8 5505.3 4867.6 5031.2 5052.9 5169.6 5234.3 2863.1 2871.3 2906.9 2915.1 2936.8 5459.7 5506.2 5517.8 5527.9 5556.0 5176.7 5423.8 5430.7 5445.7 5448.0 5542.6 5568.5 5595.5 5611.6 5630.5 5278.2 5328.7 5339.6 5418.8 5798.6 6010.8 6080.5 6085.5 6097.4 6113.5 6180.2 6385.7 6393.5 6414.1 6429.9 4348.7 4386.2 4398.5 4400.2 4406.3 6000.3 6112.4 6117.7 6166.8 6280.7 5948.7 5950.6 5951.9 5981.9 6000.3 6006.8 6020.6 6034.4 6042.4 6081.7 5637.3 5911.4 5923.6 5945.6 5968.5 5979.8 6034.2 6104.3 6107.2 6108.5 5631.3 5828.2 5885.1 5963.7 5985.4 04:42:26 INFO - PROCESS | 9564 | 04:42:26 INFO - PROCESS | 9564 | [#5] yui.html Cycles:180 Average:19782.36 Median:53134.60 stddev:26590.26 (50.0%) stddev-sans-first:26626.63 04:42:26 INFO - PROCESS | 9564 | Values: 793.9 819.6 850.5 873.7 923.2 14562.4 15007.7 15820.2 15824.6 15856.8 15789.5 15825.2 15883.8 15959.4 15965.4 857.6 882.9 887.7 889.8 893.6 880.8 886.1 887.8 889.2 890.3 925.4 925.8 926.4 927.9 929.3 919.3 919.9 920.9 921.2 922.8 674.1 674.5 675.3 677.1 678.9 16641.6 16672.7 16750.2 16786.7 16809.7 13898.0 14857.9 15093.4 15150.4 15300.6 14004.3 14230.9 14265.9 14290.6 14323.0 4737.4 4744.7 4757.4 4927.0 4940.5 80033.6 80958.0 81626.0 81626.6 82527.2 12138.1 12145.5 12293.6 12348.9 12369.6 21364.7 21377.9 21505.2 21680.0 21687.5 8433.7 8470.4 8475.9 8498.7 8600.4 4950.4 5030.8 5062.9 5077.3 5194.7 3617.0 3670.7 3720.9 3727.4 3729.9 677.2 685.2 687.9 695.1 699.1 633.0 699.6 727.7 732.3 742.4 8933.4 9121.8 9207.7 9279.4 9398.0 616.8 656.3 724.6 771.8 778.0 4302.2 4372.4 4537.9 4614.3 4653.9 73158.3 73360.3 73410.3 84811.6 93328.5 63117.7 64977.7 92483.5 95265.0 97819.0 83593.2 85183.1 85500.6 87634.0 87995.6 8157.2 8258.6 8316.6 8383.9 8506.2 53125.5 53143.7 53617.5 53843.0 54033.2 71579.0 75068.6 76220.0 76289.0 78693.6 12267.9 12463.6 12483.6 12566.7 12739.2 12561.6 12621.3 13218.3 13478.5 13669.5 12472.6 12490.7 12602.0 12863.0 13069.2 12560.7 12714.6 13176.0 13188.5 14551.6 14573.9 14772.3 14860.5 15343.2 15599.8 11279.8 11376.7 11786.4 11978.8 12349.3 12124.2 12131.9 13133.3 13150.5 13437.2 04:42:26 INFO - PROCESS | 9564 | -------- Summary: end -------- 04:42:26 INFO - PROCESS | 9564 | 04:42:27 INFO - TEST-INFO | 9564: exit 0 04:42:27 INFO - TEST-OK | dromaeo_css | took 1110117ms 04:42:27 INFO - TEST-START | kraken 04:42:27 INFO - operating with platform_type : linux_ 04:42:27 INFO - Initialising browser for kraken test... 04:42:27 INFO - TEST-INFO | started process 9805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnWzsOB/profile http://localhost:50636/getInfo.html) 04:42:31 INFO - PROCESS | 9805 | __metrics Screen width/height:1600/1200 04:42:31 INFO - PROCESS | 9805 | colorDepth:24 04:42:31 INFO - PROCESS | 9805 | Browser inner width/height: 1024/697 04:42:31 INFO - PROCESS | 9805 | __metrics 04:42:32 ERROR - PROCESS | 9805 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:42:33 INFO - TEST-INFO | 9805: exit 0 04:42:33 INFO - Browser initialized. 04:42:33 INFO - Running cycle 1/1 for kraken test... 04:42:33 INFO - TEST-INFO | started process 9936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnWzsOB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:45 INFO - PROCESS | 9936 | RSS: Main: 156512256 04:42:45 INFO - PROCESS | 9936 | 04:42:47 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50636/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:48 INFO - PROCESS | 9936 | RSS: Main: 161861632 04:42:48 INFO - PROCESS | 9936 | 04:42:51 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50636/tests/kraken/driver.html?testName=audio-dft) 04:42:51 INFO - PROCESS | 9936 | RSS: Main: 160727040 04:42:51 INFO - PROCESS | 9936 | 04:42:54 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50636/tests/kraken/driver.html?testName=audio-fft) 04:42:55 INFO - PROCESS | 9936 | RSS: Main: 161644544 04:42:55 INFO - PROCESS | 9936 | 04:42:57 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50636/tests/kraken/driver.html?testName=audio-oscillator) 04:42:57 INFO - PROCESS | 9936 | RSS: Main: 161210368 04:42:57 INFO - PROCESS | 9936 | 04:43:00 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:00 INFO - PROCESS | 9936 | RSS: Main: 161148928 04:43:00 INFO - PROCESS | 9936 | 04:43:03 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50636/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:04 INFO - PROCESS | 9936 | RSS: Main: 160841728 04:43:04 INFO - PROCESS | 9936 | 04:43:07 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50636/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:08 INFO - PROCESS | 9936 | RSS: Main: 161570816 04:43:08 INFO - PROCESS | 9936 | 04:43:11 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50636/tests/kraken/driver.html?testName=json-parse-financial) 04:43:11 INFO - PROCESS | 9936 | RSS: Main: 161157120 04:43:11 INFO - PROCESS | 9936 | 04:43:13 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:14 INFO - PROCESS | 9936 | RSS: Main: 160833536 04:43:14 INFO - PROCESS | 9936 | 04:43:15 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:16 INFO - PROCESS | 9936 | RSS: Main: 160235520 04:43:16 INFO - PROCESS | 9936 | 04:43:18 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:19 INFO - PROCESS | 9936 | RSS: Main: 161251328 04:43:19 INFO - PROCESS | 9936 | 04:43:21 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:22 INFO - PROCESS | 9936 | RSS: Main: 161722368 04:43:22 INFO - PROCESS | 9936 | 04:43:25 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:25 INFO - PROCESS | 9936 | RSS: Main: 161325056 04:43:25 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:50636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50636/tests/kraken/driver.html?testName=ai-astar) 04:43:27 INFO - PROCESS | 9936 | RSS: Main: 162447360 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | __start_tp_report 04:43:27 INFO - PROCESS | 9936 | _x_x_mozilla_page_load 04:43:27 INFO - PROCESS | 9936 | _x_x_mozilla_page_load_details 04:43:27 INFO - PROCESS | 9936 | |i|pagename|runs| 04:43:27 INFO - PROCESS | 9936 | |0;ai-astar;111;105;110;112;111;110;112;114;109;110 04:43:27 INFO - PROCESS | 9936 | |1;audio-beat-detection;148;128;155;173;130;169;159;125;184;129 04:43:27 INFO - PROCESS | 9936 | |2;audio-dft;162;166;161;165;164;165;164;163;162;165 04:43:27 INFO - PROCESS | 9936 | |3;audio-fft;77;79;74;181;76;77;75;76;181;76 04:43:27 INFO - PROCESS | 9936 | |4;audio-oscillator;86;85;146;85;86;85;151;84;84;151 04:43:27 INFO - PROCESS | 9936 | |5;imaging-gaussian-blur;119;119;117;118;118;118;118;118;117;118 04:43:27 INFO - PROCESS | 9936 | |6;imaging-darkroom;147;148;147;147;146;147;148;147;147;147 04:43:27 INFO - PROCESS | 9936 | |7;imaging-desaturate;95;95;97;96;96;96;100;96;96;96 04:43:27 INFO - PROCESS | 9936 | |8;json-parse-financial;53;52;55;54;55;57;60;56;52;53 04:43:27 INFO - PROCESS | 9936 | |9;json-stringify-tinderbox;61;62;61;62;64;62;62;62;61;63 04:43:27 INFO - PROCESS | 9936 | |10;stanford-crypto-aes;75;76;76;76;75;76;78;76;100;77 04:43:27 INFO - PROCESS | 9936 | |11;stanford-crypto-ccm;140;117;138;116;134;116;117;120;127;130 04:43:27 INFO - PROCESS | 9936 | |12;stanford-crypto-pbkdf2;154;156;155;159;160;155;155;158;165;153 04:43:27 INFO - PROCESS | 9936 | |13;stanford-crypto-sha256-iterative;67;66;62;69;63;65;62;63;60;62 04:43:27 INFO - PROCESS | 9936 | __end_tp_report 04:43:27 INFO - PROCESS | 9936 | __start_cc_report 04:43:27 INFO - PROCESS | 9936 | _x_x_mozilla_cycle_collect,862 04:43:27 INFO - PROCESS | 9936 | __end_cc_report 04:43:27 INFO - PROCESS | 9936 | __startTimestamp1469619807582__endTimestamp 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | ------- Summary: start ------- 04:43:27 INFO - PROCESS | 9936 | Number of tests: 14 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.37 (2.1%) stddev-sans-first:2.50 04:43:27 INFO - PROCESS | 9936 | Values: 111.0 105.0 110.0 112.0 111.0 110.0 112.0 114.0 109.0 110.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:157.00 stddev:21.36 (13.6%) stddev-sans-first:22.64 04:43:27 INFO - PROCESS | 9936 | Values: 148.0 128.0 155.0 173.0 130.0 169.0 159.0 125.0 184.0 129.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.50 stddev:1.64 (1.0%) stddev-sans-first:1.62 04:43:27 INFO - PROCESS | 9936 | Values: 162.0 166.0 161.0 165.0 164.0 165.0 164.0 163.0 162.0 165.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#3] audio-fft Cycles:10 Average:97.20 Median:76.00 stddev:44.19 (58.1%) stddev-sans-first:46.26 04:43:27 INFO - PROCESS | 9936 | Values: 77.0 79.0 74.0 181.0 76.0 77.0 75.0 76.0 181.0 76.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.00 stddev:31.11 (36.6%) stddev-sans-first:32.29 04:43:27 INFO - PROCESS | 9936 | Values: 86.0 85.0 146.0 85.0 86.0 85.0 151.0 84.0 84.0 151.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:43:27 INFO - PROCESS | 9936 | Values: 119.0 119.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:43:27 INFO - PROCESS | 9936 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 04:43:27 INFO - PROCESS | 9936 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 100.0 96.0 96.0 96.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:2.50 (4.5%) stddev-sans-first:2.57 04:43:27 INFO - PROCESS | 9936 | Values: 53.0 52.0 55.0 54.0 55.0 57.0 60.0 56.0 52.0 53.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 04:43:27 INFO - PROCESS | 9936 | Values: 61.0 62.0 61.0 62.0 64.0 62.0 62.0 62.0 61.0 63.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:76.00 stddev:7.60 (10.0%) stddev-sans-first:7.96 04:43:27 INFO - PROCESS | 9936 | Values: 75.0 76.0 76.0 76.0 75.0 76.0 78.0 76.0 100.0 77.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:128.50 stddev:9.52 (7.4%) stddev-sans-first:8.54 04:43:27 INFO - PROCESS | 9936 | Values: 140.0 117.0 138.0 116.0 134.0 116.0 117.0 120.0 127.0 130.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:3.59 (2.3%) stddev-sans-first:3.64 04:43:27 INFO - PROCESS | 9936 | Values: 154.0 156.0 155.0 159.0 160.0 155.0 155.0 158.0 165.0 153.0 04:43:27 INFO - PROCESS | 9936 | 04:43:27 INFO - PROCESS | 9936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:2.77 (4.3%) stddev-sans-first:2.70 04:43:27 INFO - PROCESS | 9936 | Values: 67.0 66.0 62.0 69.0 63.0 65.0 62.0 63.0 60.0 62.0 04:43:27 INFO - PROCESS | 9936 | -------- Summary: end -------- 04:43:27 INFO - PROCESS | 9936 | 04:43:28 INFO - TEST-INFO | 9936: exit 0 04:43:28 INFO - TEST-OK | kraken | took 61160ms 04:43:28 INFO - SUITE-END | took 1171s 04:43:28 INFO - Completed test suite (00:19:31) 04:43:28 INFO - javascript benchmark 04:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7600.43140491679, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.358491886543, 3388.5256064151017, 3419.452887537994, 3444.7416443766706, 3445.9827700861506, 5603.87922415517, 5635.492805647491, 5665.036943719567, 5695.544356451484, 5763.567732420064, 5690.971545142268, 5722.456366645162, 5756.3092428908585, 5757.654540727559, 5762.250907382045, 5164.92252616211, 5224.895502089956, 5266.368035835686, 5299.814506492274, 5323.041852466555, 5165.354330708661, 5169.457206993268, 5313.149896016638, 5314.495122963332, 5316.813911513098, 5228.268042474037, 5253.448387919251, 5254.474552544753, 5277.656952298088, 5281.735913204344, 5272.23552584875, 5310.097283461821, 5324.281222035033, 5328.49379308965, 5334.759935802898, 5050.570701490377, 5165.638405311592, 5225.372955245357, 5256.421793602701, 5256.474352564751, 5510.421405752419, 5510.559155267569, 5551.000819852425, 5597.3003374578175, 5612.298462692163, 6098.32918378978, 6108.602940808833, 6130.724117414727, 6149.385061493815, 6168.228971378578, 5956.047032474827, 6075.787347442818, 6206.627602343874, 6216.564840461169, 6217.56477046607, 5686.2607860977805, 5751.309842818889, 5754.827355179351, 5783.045797443417, 5811.15738217956, 6290.779822706183, 6296.244450665858, 6299.842503937347, 6323.43089121972, 6333.936660633427, 5846.327672317738, 6054.8183554493435, 6059.182010428536, 6072.635641861502, 6115.235595550556, 6179.660118693515, 6194.34959329273, 6195.039768835748, 6200.038993955944, 6210.347913469111, 6107.938920610826, 6127.387261273837, 6151.753929842756, 6159.137720719103, 6191.938080619136, 5980.790672326448, 6081.057436097412, 6111.633302001894, 6112.716259964451, 6160.507159427235, 4737.526247375235, 4739.644526660514, 4741.95258047422, 4768.856934291976, 4782.569568738761, 4224.78876056196, 4239.554846741048, 4241.448611680462, 4247.426597409372, 4270.765107919032, 5688.431156884361, 5864.67744274069, 5897.439743224387, 5915.349311575723, 5915.526757859447, 6116.785912493041, 6124.234470691164, 6134.018557030854, 6179.938200618026, 6211.440970312603, 5787.681677507778, 5961.970190149022, 5967.5524335675, 5976.701164941735, 5996.580239383288, 5294.047071527162, 5311.681299122065, 5322.3879253885525, 5360.812371566976, 5390.137577987503, 6427.357264273535, 6459.257185423737, 6486.351364863476, 6488.221413430419, 6490.513211509061, 5922.378150294329, 6106.145139680537, 6237.282712488122, 6240.251169859646, 6254.4996400286955, 6311.589746666452, 6415.582987105823, 6435.742570297136, 6453.9354606453335, 6467.708953097216, 6018.398160183947, 6044.516438684983, 6045.939540604713, 6062.757489700362, 6066.636001839904, 6018.217631708025, 6118.60229085108, 6126.754929802936, 6148.78479253224, 6191.349908259568, 6058.0, 6097.5426842987845, 6103.816885493442, 6117.082437634391, 6132.601380910227, 6053.364396738279, 6060.333363330118, 6066.15073889647, 6072.635641861502, 6079.422454866781, 5561.4716601922755, 5829.446202610745, 5900.055991041413, 5906.055031194988, 5958.702064896825, 6025.337212906489, 6031.4270144336215, 6040.879182416415, 6042.909356359746, 6071.362506936708, 5972.0, 5976.252968378953, 5979.970100149471, 5985.102234664835, 5999.4900433463645], "value": 5684.629819443751, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6013661052012, 651.7425616881332, 658.2495954611743, 682.1507223506733, 682.3722175598449, 42231.15537689248, 46001.0, 46041.53958460423, 46234.768826155865, 46368.30447543285, 46385.30422043672, 46972.0, 47001.764991175, 47019.0, 47028.0, 8917.554122293892, 9082.13719696631, 9088.727338179866, 9092.954535227347, 9140.131687489678, 9034.86447703285, 9126.315526335551, 9138.360314777969, 9143.268538516935, 9158.86261706075, 9148.72553823383, 9170.954145229265, 9174.678886238982, 9175.0, 9199.356045076847, 9109.863352049724, 9109.954450227773, 9116.453012819253, 9144.4970526621, 9153.450792952377, 9046.321525885585, 9115.0, 9132.0, 9132.771680708036, 9136.497492637902, 43396.566034339885, 43644.908877278, 43762.34356484655, 43790.56209437897, 43819.56180438187, 3824.158685089276, 3917.251775159663, 4396.868093957187, 4425.048614547888, 4509.120721459317, 34522.0, 34571.481427778606, 35123.824380878184, 35187.824060879786, 36144.27711445783, 4745.39964000416, 4758.452777930513, 4791.904161916777, 4805.831795887128, 4865.2945322928335, 262395.0, 263325.0, 263471.6826415875, 263980.0, 264470.0, 34592.308153837286, 64977.35022649713, 65989.0, 66012.66993665001, 66083.33916660868, 41498.79250603728, 41587.37618935719, 41674.0, 41706.165876682295, 41711.582884171374, 17486.47540573785, 17702.203400846993, 17706.91146544259, 17720.0, 17747.73378399325, 12941.741165176833, 12973.481060757464, 13046.804297935538, 13108.082434229704, 13123.212607243597, 9215.769605759775, 9241.861372079424, 9242.722718318326, 9293.442393456278, 9342.299327550461, 3521.7182625389905, 3546.680798728127, 3564.4118720410843, 3597.586277578112, 3618.5295911531857, 1073.7906108308962, 1111.955521779136, 1114.2478826791883, 1181.5037684172669, 1226.3745489800267, 34263.143421414665, 34629.13427164341, 34808.0, 34947.0, 35436.0, 1173.8650055243586, 1213.7754515414676, 1227.735432504504, 1256.466001949168, 1350.3113412159869, 17750.0, 18039.909800451176, 18044.458666240032, 18168.182431790337, 18360.632787344177, 608916.0, 611079.0, 612255.0, 614241.0, 617269.0, 66624.0, 67142.32857671361, 67320.6633966827, 67389.66305168443, 67428.0, 1462.56854228003, 1487.5983484459352, 1488.6724920517686, 1518.627936155649, 1522.5356266338651, 32597.0, 32962.34075318528, 33103.33793324072, 33266.66733332733, 33763.0, 56846.0, 56888.0, 57268.42731572631, 57498.42501574931, 57764.0, 465253.0, 465445.0, 465872.0, 466634.0, 467653.0, 30954.845225773726, 31144.0, 31157.53263701001, 31172.68827311698, 31323.0, 52605.0, 52825.471745282055, 53989.73005134949, 54054.0, 54700.726496367264, 45644.31533526933, 46268.305975411065, 46384.53615463802, 46424.53575464202, 47068.7646561765, 44780.77609611931, 45232.0, 45627.0, 46257.0, 46888.0, 40814.183716324915, 44383.33424998563, 45135.54864451445, 46271.53728462672, 48224.276635851194, 39293.41059884161, 39851.40222896717, 39907.60092399039, 39919.0, 39968.60031399649, 29589.408211835213, 30109.247268818453, 30428.391432171677, 30441.543376848924, 30577.0], "value": 20345.708533214594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.0303913156266, 430.35876543949513, 430.5758827554859, 430.81905599648144, 447.3178402935523, 18422.723659145107, 19443.708344374827, 20062.197512099516, 20815.27146549871, 20871.165153393846, 19797.847607433763, 20302.69545956808, 20592.897035514838, 20898.37304880856, 20910.581788364223, 5651.2935883014525, 5877.089051197071, 5893.233879595647, 5918.0, 5926.822195334147, 5611.7474713637985, 5726.3987281335485, 5784.739686714087, 5802.332731735863, 5809.7676092956235, 5716.857078573048, 5727.599068065237, 5753.568482363839, 5765.394633563478, 5778.24882765242, 5544.695041772701, 5580.720963951807, 5597.216389705465, 5625.240592519998, 5633.070543360341, 5021.748912554358, 5033.370828646419, 5041.0, 5052.317937078484, 5062.392512898476, 22746.772532274797, 23529.0, 23814.404639883967, 23843.0, 23900.641490377657, 2713.592961055838, 2721.700612932576, 2728.4133911208987, 2769.418422131355, 2824.5057115004793, 14402.567922962224, 15113.773293400498, 15433.074015559103, 15456.845431545653, 15477.148756818371, 1984.9233687783876, 1987.6124155789628, 2002.019010684754, 2070.513429344103, 2129.4463439505685, 81338.0, 82914.0, 83206.0, 83337.58331208366, 83361.58319208426, 11104.500297486633, 11160.720981975353, 11448.141389395829, 11450.0, 11592.1305902056, 15885.444009459614, 15888.0, 15910.284037218353, 15985.840141598668, 15990.920045399698, 8573.957130214309, 8679.91320086791, 8801.295896328407, 8828.42615230008, 8860.778480538038, 8390.077091519928, 8477.321814254845, 8621.66364213548, 8683.522406267715, 8772.868406973901, 6884.690188941509, 6933.687984040629, 7020.016492990459, 7111.502194846415, 7175.210726820045, 1839.7424360589528, 2002.5294055896852, 2057.6399130152463, 2079.0913083403407, 2091.4771307173205, 986.40815510693, 1096.7098703888335, 1116.4752566293828, 1123.3035517978906, 1156.8206927926185, 19410.611787764166, 20201.898990505248, 20331.695024574645, 20718.48203794887, 20781.792182078287, 1116.4083035990939, 1126.814075677504, 1134.8127558952845, 1155.7919574476507, 1184.7571247894161, 11063.170262230366, 11543.480543375568, 11634.069274458023, 11776.11679124069, 11880.76238475243, 555274.0, 557806.0, 561120.0, 569318.0, 575409.0, 80303.0, 84122.0, 85096.57451712702, 86117.56941215254, 86437.0, 1128.8758236593967, 1138.6014894786758, 1147.6729132197283, 1165.0330225912471, 1179.2334982261427, 17376.652466950844, 17808.55478612993, 18131.0, 18313.633727325112, 18414.17136228846, 39716.80141599273, 41011.7949410251, 44086.0, 44339.0, 44972.55027449683, 57774.42225577858, 57895.0, 57959.13061304, 58965.0, 60029.69985150046, 6743.561668491532, 7843.294103530709, 8688.91311086881, 9115.817683646157, 9374.0, 9657.806843863224, 12466.376681166086, 12519.812202817147, 12559.43482543306, 12587.370631468573, 11032.227744057838, 11171.21801473889, 11285.830712539155, 11337.603183888854, 11374.488148033524, 10643.627473038407, 10659.4137322448, 10787.67636970892, 10800.945995269973, 11148.0, 10834.295770774874, 10967.122630189406, 11164.72088197769, 11231.494582743633, 11327.847708935276, 8756.080611535952, 8825.117488251124, 8964.506952117696, 8989.235914947041, 9093.4998575079, 10803.081738052353, 10973.23187376876, 11063.170262230204, 11155.944220278847, 11194.328340299608], "value": 9670.827633226225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1600.8559229669331, 1606.2290100751638, 1826.8629852761046, 1886.0, 1910.4173227165718, 8627.309815214783, 9270.768230794225, 9456.432614043162, 9989.100980911726, 9992.900070999287, 9504.477253751042, 9799.314048016642, 9806.21550275978, 9926.950365248164, 9939.552720127593, 2495.114234446768, 2523.3691577105724, 2523.73500782418, 2526.6589010483626, 2526.759957804006, 2218.567379361017, 2292.2893902890073, 2295.735990361105, 2299.7700229976954, 2303.735070466901, 2491.489244704831, 2515.295717199187, 2528.05198050731, 2528.1657053172503, 2532.2656429635385, 2515.220281712675, 2516.949661006788, 2520.5211009908057, 2534.581794003987, 2553.182981445938, 2513.17065368428, 2539.149384956042, 2556.3864672478658, 2581.083715281067, 2585.108137692493, 9611.990740972167, 9628.614855405775, 9686.370385924964, 9704.854427183598, 9735.075167859042, 5565.526930210937, 5925.644461332291, 5983.820485385445, 5991.430814072656, 6010.128531362928, 3651.3062518121737, 3744.8689295874515, 3766.0961369271454, 3792.317382871082, 3869.6323849234277, 1132.6149109302876, 1155.2086820527966, 1159.7390587117916, 1171.2094336322948, 1183.4615250061202, 14036.649083772885, 14040.087394319438, 14043.22762248076, 14046.297685115704, 14078.084924479876, 5165.845024649267, 5201.45384734605, 5206.55744261742, 5250.398628418369, 5257.605679574047, 11607.30356178632, 11648.242864213798, 11688.590899318484, 11703.707407314714, 11719.765604687858, 6004.54965877561, 6011.248593925759, 6014.067819487899, 6037.728302226323, 6068.393160683984, 4872.074305881871, 5332.0, 5443.836684899459, 5498.5876059295715, 5498.917516237259, 4424.446944131983, 4463.575960283768, 4506.842260520932, 4527.592516673515, 4531.84138555149, 1399.803168291117, 1403.5999740074235, 1422.4807945099965, 1424.287856071964, 1436.899417040797, 968.1722127580957, 1063.4310643805527, 1066.8399740038901, 1083.4853444613746, 1096.6490722968574, 6551.0, 6615.966920165464, 6685.899711504331, 6701.865962680817, 6754.200789503862, 495.2027236149796, 500.56951022120944, 504.0523815227349, 513.3121617033194, 513.5301199402505, 4573.885652858638, 4581.656375771764, 4629.65277604181, 4630.930536041962, 4636.11913736389, 12061.939690301493, 12482.563110291096, 12563.623091307092, 12600.306983116017, 12616.81074783879, 11680.0, 12094.637160885188, 12100.33448160342, 12434.0, 12487.375631218403, 9034.412763170372, 9084.273258139334, 9116.361854670242, 9142.222911052502, 9203.861942070875, 6639.601623902581, 6780.694868731018, 6831.157424042768, 6836.863262734817, 7006.194287656985, 11284.492197851281, 11469.426528673699, 11479.885201147881, 11554.653360399201, 11681.415929203336, 11552.480138393625, 11739.941300293785, 11749.412529373669, 11831.40842957866, 11908.940455297668, 7898.328642065489, 8511.74464766058, 8789.121087891159, 8815.867761983704, 8955.731328060168, 9791.46146961924, 9794.510274486105, 9828.361156524803, 9910.801783964425, 9931.900680993098, 8399.202075802788, 8407.579621018802, 8476.194761497647, 8605.784855378666, 8832.5583720815, 7993.280604745601, 8003.679852806055, 8226.629801659059, 8436.0, 8439.029511606244, 7530.28462296081, 7754.457187996786, 7758.185390534139, 7907.8813817793925, 7908.130105688485, 5698.572607054571, 5761.251037365116, 5820.854478638068, 5864.501517371071, 5875.882482350415, 5706.80026199081, 5718.1708652246025, 5745.368009519033, 5846.970765146147, 5891.1457838612305], "value": 5055.632453711317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.89413176047185, 356.41903696973935, 359.89023347878884, 360.06024276637953, 363.521968611276, 5681.460261275178, 5692.544596432286, 5698.857528561788, 5718.9428105718935, 5770.076787713967, 5571.832845014656, 5594.356648985368, 5625.774969001235, 5636.887262254752, 5655.010373184687, 4260.446142001535, 4391.692581519295, 4404.14119246747, 4404.427424434835, 4410.580994805505, 4355.0, 4412.0, 4413.845515406962, 4429.379886815832, 4432.135733531963, 4372.300431930892, 4389.758563279034, 4391.429114215163, 4404.383386325917, 4405.757683327416, 4166.64583510402, 4354.6516278697945, 4376.0, 4382.934255986131, 4447.911041779163, 3835.3863381859046, 3837.270918525499, 3841.9423708644395, 3845.442410850411, 3853.2486165197797, 5369.275147855029, 5447.6459030163305, 5448.318960129984, 5457.972710136463, 5513.42109078549, 4905.4358748744, 4947.431045429786, 4954.801807927714, 5006.799728010875, 5025.3718285214345, 5881.79413720522, 5883.676172861072, 5899.675517846516, 5922.2597175353085, 5994.520438364921, 4237.4915010198665, 4253.1706317268145, 4283.164782867342, 4284.892877678052, 4294.3558466230315, 5879.2944846618675, 6003.699815009276, 6032.607880487754, 6150.9245377311345, 6152.24450338346, 4278.4865816102265, 4285.935710964338, 4297.957020429756, 4302.139572085595, 4314.115606300701, 4359.694821362475, 4366.279563871989, 4369.80335884886, 4388.758618275961, 4396.626286765661, 4899.461059283476, 4968.850934471971, 5014.423341315723, 5024.120778863758, 5036.32009678696, 5865.20819689345, 5909.8227053188475, 5909.847579721913, 5917.201177841022, 5957.791477298274, 1464.4288727396324, 1502.5642563656418, 1514.8409417011276, 1520.049968769519, 1521.8325984141736, 941.3363578677016, 960.8750862387984, 969.5685419988179, 971.1939090554822, 983.9754006149903, 5066.9478861061325, 5101.51535604117, 5156.896862062813, 5182.564194828425, 5227.3465816772905, 5413.404525502192, 5442.394493624391, 5485.835424937259, 5497.752601132958, 5505.256790333254, 4867.610591152699, 5031.245313203049, 5052.949470505321, 5169.560587350042, 5234.293370395024, 2863.053123875743, 2871.2821794551364, 2906.941861162807, 2915.090615646755, 2936.779741519352, 5459.669601543055, 5506.229127922094, 5517.813670060957, 5527.861803454865, 5555.972220138954, 5176.663516871391, 5423.810166644149, 5430.723779911717, 5445.673259604358, 5448.0, 5542.61201715876, 5568.470995255444, 5595.496405323622, 5611.569049892251, 5630.451625802855, 5278.205410160564, 5328.66783304174, 5339.626226164131, 5418.83743487696, 5798.59409841307, 6010.789622363196, 6080.543959202989, 6085.543584231289, 6097.420745029215, 6113.5414843886, 6180.227471566054, 6385.744570217139, 6393.456556192776, 6414.134091897721, 6429.871402571829, 4348.7390756554705, 4386.188555117314, 4398.516163221979, 4400.207962566768, 4406.272964960745, 6000.279966404059, 6112.449879510866, 6117.663528505975, 6166.828302622487, 6280.7487700491465, 5948.702564871825, 5950.642961422329, 5951.851203719769, 5981.880362392815, 6000.339962604197, 6006.819795406145, 6020.608660437058, 6034.370719905689, 6042.395760424099, 6081.726322315418, 5637.3235211774845, 5911.438413350725, 5923.614965027259, 5945.554083443672, 5968.522518198447, 5979.760809567569, 6034.185384972972, 6104.26748790148, 6107.236595425572, 6108.541859360477, 5631.324241091095, 5828.213191219131, 5885.14665373527, 5963.671998040149, 5985.40145985398], "value": 4410.224168245452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.8848866914298, 819.5533434278318, 850.5194565070735, 873.7029410000598, 923.1783712495876, 14562.417503299868, 15007.699846003074, 15820.20898955052, 15824.604384890383, 15856.84143158568, 15789.526314210592, 15825.208739563033, 15883.841161588382, 15959.361625534993, 15965.361385544564, 857.5755001274363, 882.9470231786113, 887.6671248281895, 889.8042430665244, 893.5889490834192, 880.7842078690729, 886.0784783824814, 887.8490656588395, 889.2263730554427, 890.2699786175307, 925.4077390470104, 925.7870689741363, 926.3561824531953, 927.9257659387266, 929.2751653710117, 919.2508105893676, 919.935604507688, 920.9309301802392, 921.1617428140394, 922.8062106957547, 674.1202730436778, 674.4840197249108, 675.2841987493224, 677.1028387386732, 678.8879834827247, 16641.583960400967, 16672.74990875138, 16750.16249187536, 16786.74819877703, 16809.66380672392, 13898.0, 14857.925710371486, 15093.39626414942, 15150.393984240618, 15300.617484562863, 14004.29978501071, 14230.928845355811, 14265.91765880406, 14290.64273393163, 14323.0, 4737.407824021997, 4744.691595046311, 4757.381540399726, 4927.039227350668, 4940.530649588283, 80033.59983200047, 80958.0, 81626.0, 81626.59186704087, 82527.17472825314, 12138.08964327679, 12145.514179432901, 12293.56972505958, 12348.938255308845, 12369.62891113268, 21364.679529807065, 21377.89311053466, 21505.24731634385, 21680.0, 21687.457813554473, 8433.662653493915, 8470.364722645827, 8475.872861907077, 8498.74503764888, 8600.440971336842, 4950.4059512858685, 5030.84907452777, 5062.873428164326, 5077.26379674945, 5194.740262986836, 3616.9819150904605, 3670.6879915207505, 3720.8511659533856, 3727.3849814780256, 3729.9067523312133, 677.190757045336, 685.2462291479333, 687.9174499060144, 695.1449716848305, 699.105145413871, 632.9651869147241, 699.5942353434996, 727.7452891488043, 732.2677322677323, 742.417202496038, 8933.419327743806, 9121.771955701028, 9207.669414260734, 9279.350445468752, 9398.0, 616.7810427298334, 656.2715385921623, 724.5616402076773, 771.8417724366492, 778.0, 4302.182585308781, 4372.3878656988045, 4537.886552836206, 4614.341766076729, 4653.930191047137, 73158.26841731515, 73360.26639733535, 73410.2658973414, 84811.57594211989, 93328.53335733278, 63117.68441157765, 64977.67511162508, 92483.53758231166, 95265.0, 97819.0, 83593.16406835854, 85183.14816851876, 85500.57249713836, 87634.0, 87995.56002219948, 8157.184281572033, 8258.587070646563, 8316.62575184106, 8383.916160838313, 8506.234438900281, 53125.46874531205, 53143.73428132989, 53617.46382536125, 53843.0, 54033.18950215828, 71579.0, 75068.62465687636, 76220.0, 76289.0, 78693.60653196697, 12267.938660306998, 12463.626091217278, 12483.56307529232, 12566.748665026465, 12739.171953822972, 12561.623151305475, 12621.286870463153, 13218.272994985367, 13478.52825151115, 13669.521566745116, 12472.563460278847, 12490.687732806753, 12602.0, 12863.0, 13069.15050521713, 12560.685982850502, 12714.61856144317, 13176.0, 13188.472461101832, 14551.563453096423, 14573.854261457675, 14772.261386930395, 14860.479883204036, 15343.23283835826, 15599.766003510184, 11279.7744045117, 11376.658700239006, 11786.351750653454, 11978.76042479163, 12349.32078735678, 12124.211926224767, 12131.878681213428, 13133.277669728257, 13150.539731109366, 13437.193768373929], "value": 7728.8395055178935, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 112.0, 111.0, 110.0, 112.0, 114.0, 109.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 155.0, 173.0, 130.0, 169.0, 159.0, 125.0, 184.0, 129.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 161.0, 165.0, 164.0, 165.0, 164.0, 163.0, 162.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 74.0, 181.0, 76.0, 77.0, 75.0, 76.0, 181.0, 76.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 146.0, 85.0, 86.0, 85.0, 151.0, 84.0, 84.0, 151.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 54.0, 55.0, 57.0, 60.0, 56.0, 52.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 64.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 76.0, 75.0, 76.0, 78.0, 76.0, 100.0, 77.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 138.0, 116.0, 134.0, 116.0, 117.0, 120.0, 127.0, 130.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 155.0, 159.0, 160.0, 155.0, 155.0, 158.0, 165.0, 153.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 62.0, 69.0, 63.0, 65.0, 62.0, 63.0, 60.0, 62.0], "value": 63.9, "unit": "score"}]}]} 04:43:28 INFO - Return code: 0 04:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:28 ERROR - # TBPL SUCCESS # 04:43:28 INFO - Running post-action listener: _resource_record_post_action 04:43:28 INFO - ##### 04:43:28 INFO - ##### Finished run-tests step (success) 04:43:28 INFO - ##### 04:43:28 INFO - Running post-run listener: _resource_record_post_run 04:43:28 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 511766528; Read time: 32; Write time: 457624 04:43:28 INFO - TinderboxPrint: CPU usage
13.4% 04:43:28 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 04:43:28 INFO - TinderboxPrint: I/O write bytes / time
511,766,528 / 457,624 04:43:28 INFO - TinderboxPrint: CPU idle
8,205.7 (86.6%) 04:43:28 INFO - TinderboxPrint: CPU user
1,216.4 (12.8%) 04:43:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259985408; Read time: 0; Write time: 307876 04:43:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251781120; Read time: 32; Write time: 149748 04:43:29 INFO - Running post-run listener: _upload_blobber_files 04:43:29 INFO - Blob upload gear active. 04:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:29 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 04:43:29 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:29 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:31 INFO - (blobuploader) - INFO - Done attempting. 04:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:31 INFO - (blobuploader) - INFO - Done attempting. 04:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:36 INFO - (blobuploader) - INFO - Done attempting. 04:43:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:36 INFO - Return code: 0 04:43:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb9b602abea313db110a47a6452a6b2228a5aa4a95d1f178a432e2524763eb14f549631625b2efbfcef781ec07dd5379d77b44259a7ee56963381b0546abb457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e96e2481d5fca2d86361f5d83c115979d3fb91c8d8c535d6abe9ae98651db32450e469e165ef08d0c8f1c64a2f96c345d0d0539259342ea91ec9c895700daf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cfa944e3d2e252b59698d7a0774daa9b38f890b83e1565cce9bc5290ae42517bce5d0a7b82d71f721ff554503c7a35bb03995d075135614705ffacf7a8f3eca"} 04:43:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:36 INFO - Contents: 04:43:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb9b602abea313db110a47a6452a6b2228a5aa4a95d1f178a432e2524763eb14f549631625b2efbfcef781ec07dd5379d77b44259a7ee56963381b0546abb457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e96e2481d5fca2d86361f5d83c115979d3fb91c8d8c535d6abe9ae98651db32450e469e165ef08d0c8f1c64a2f96c345d0d0539259342ea91ec9c895700daf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cfa944e3d2e252b59698d7a0774daa9b38f890b83e1565cce9bc5290ae42517bce5d0a7b82d71f721ff554503c7a35bb03995d075135614705ffacf7a8f3eca"} 04:43:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:36 INFO - Copying logs to upload dir... 04:43:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.325147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 04:43:36.091285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:36.094791) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 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-Aurora/sha512/cb9b602abea313db110a47a6452a6b2228a5aa4a95d1f178a432e2524763eb14f549631625b2efbfcef781ec07dd5379d77b44259a7ee56963381b0546abb457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e96e2481d5fca2d86361f5d83c115979d3fb91c8d8c535d6abe9ae98651db32450e469e165ef08d0c8f1c64a2f96c345d0d0539259342ea91ec9c895700daf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cfa944e3d2e252b59698d7a0774daa9b38f890b83e1565cce9bc5290ae42517bce5d0a7b82d71f721ff554503c7a35bb03995d075135614705ffacf7a8f3eca"} build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb9b602abea313db110a47a6452a6b2228a5aa4a95d1f178a432e2524763eb14f549631625b2efbfcef781ec07dd5379d77b44259a7ee56963381b0546abb457", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e96e2481d5fca2d86361f5d83c115979d3fb91c8d8c535d6abe9ae98651db32450e469e165ef08d0c8f1c64a2f96c345d0d0539259342ea91ec9c895700daf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cfa944e3d2e252b59698d7a0774daa9b38f890b83e1565cce9bc5290ae42517bce5d0a7b82d71f721ff554503c7a35bb03995d075135614705ffacf7a8f3eca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:36.120321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:36.120636) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1469618579.570666-717006436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:36.204140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:43:36.204477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:43:36.204758) ========= ========= Total master_lag: 0.17 =========