builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1464958164.23 results: success (0) buildid: 20160603030242 builduid: 6445c0bda0034d32b6e02a148bc34026 revision: e27fe24a746fa839f1cabe198faf1bad42c7dc4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.233510) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.233999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.234311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.249531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.249883) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 05:49:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-06-03 05:49:24 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112174 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.632105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.632445) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017159 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.665345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:24.668795) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e27fe24a746fa839f1cabe198faf1bad42c7dc4b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e27fe24a746fa839f1cabe198faf1bad42c7dc4b --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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 05:49:25,272 truncating revision to first 12 chars 2016-06-03 05:49:25,273 Setting DEBUG logging. 2016-06-03 05:49:25,273 attempt 1/10 2016-06-03 05:49:25,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e27fe24a746f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 05:49:25,576 unpacking tar archive at: mozilla-central-e27fe24a746f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634541 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:25.337904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:25.338236) ========= script_repo_revision: e27fe24a746fa839f1cabe198faf1bad42c7dc4b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:25.338805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:25.339074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 05:49:25.357009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-03 05:49:25.357318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:26 INFO - MultiFileLogger online at 20160603 05:49:26 in /builds/slave/test 05:49:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:26 INFO - {'append_to_log': False, 05:49:26 INFO - 'base_work_dir': '/builds/slave/test', 05:49:26 INFO - 'blob_upload_branch': 'Firefox', 05:49:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:26 INFO - 'branch': 'Firefox', 05:49:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:26 INFO - 'config_files': ('talos/linux_config.py',), 05:49:26 INFO - 'default_actions': ('clobber', 05:49:26 INFO - 'read-buildbot-config', 05:49:26 INFO - 'download-and-extract', 05:49:26 INFO - 'populate-webroot', 05:49:26 INFO - 'create-virtualenv', 05:49:26 INFO - 'install', 05:49:26 INFO - 'run-tests'), 05:49:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:26 INFO - 'download_minidump_stackwalk': True, 05:49:26 INFO - 'download_symbols': 'ondemand', 05:49:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:26 INFO - 'installer_path': 'installer.exe', 05:49:26 INFO - 'log_level': 'info', 05:49:26 INFO - 'log_name': 'talos', 05:49:26 INFO - 'log_to_console': True, 05:49:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:26 INFO - 'opt_config_files': (), 05:49:26 INFO - 'pip_index': False, 05:49:26 INFO - 'sps_profile': False, 05:49:26 INFO - 'sps_profile_interval': 0, 05:49:26 INFO - 'suite': 'dromaeojs-e10s', 05:49:26 INFO - 'system_bits': '32', 05:49:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:26 INFO - 'title': 'talos-linux64-ix-015', 05:49:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:26 INFO - 'use_talos_json': True, 05:49:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:26 INFO - 'work_dir': 'build'} 05:49:26 INFO - ##### 05:49:26 INFO - ##### Running clobber step. 05:49:26 INFO - ##### 05:49:26 INFO - Running pre-action listener: _resource_record_pre_action 05:49:26 INFO - Running main action method: clobber 05:49:26 INFO - rmtree: /builds/slave/test/build 05:49:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:26 INFO - Running post-action listener: _resource_record_post_action 05:49:26 INFO - ##### 05:49:26 INFO - ##### Finished clobber step (success) 05:49:26 INFO - ##### 05:49:26 INFO - ##### 05:49:26 INFO - ##### Running read-buildbot-config step. 05:49:26 INFO - ##### 05:49:26 INFO - Running pre-action listener: _resource_record_pre_action 05:49:26 INFO - Running main action method: read_buildbot_config 05:49:26 INFO - Using buildbot properties: 05:49:26 INFO - { 05:49:26 INFO - "project": "", 05:49:26 INFO - "product": "firefox", 05:49:26 INFO - "script_repo_revision": "production", 05:49:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:49:26 INFO - "repository": "", 05:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:49:26 INFO - "buildid": "20160603030242", 05:49:26 INFO - "stage_platform": "linux64-pgo", 05:49:26 INFO - "basedir": "/builds/slave/test", 05:49:26 INFO - "nightly_build": "True", 05:49:26 INFO - "buildnumber": 741, 05:49:26 INFO - "slavename": "talos-linux64-ix-015", 05:49:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:49:26 INFO - "platform": "ubuntu64_hw", 05:49:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:26 INFO - "branch": "mozilla-central", 05:49:26 INFO - "repo_path": "mozilla-central", 05:49:26 INFO - "revision": "e27fe24a746fa839f1cabe198faf1bad42c7dc4b", 05:49:26 INFO - "pgo_build": "True", 05:49:26 INFO - "builduid": "6445c0bda0034d32b6e02a148bc34026", 05:49:26 INFO - "slavebuilddir": "test" 05:49:26 INFO - } 05:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:49:26 INFO - Running post-action listener: _resource_record_post_action 05:49:26 INFO - ##### 05:49:26 INFO - ##### Finished read-buildbot-config step (success) 05:49:26 INFO - ##### 05:49:26 INFO - ##### 05:49:26 INFO - ##### Running download-and-extract step. 05:49:26 INFO - ##### 05:49:26 INFO - Running pre-action listener: _resource_record_pre_action 05:49:26 INFO - Running main action method: download_and_extract 05:49:26 INFO - mkdir: /builds/slave/test/build/tests 05:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:26 INFO - https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:49:27 INFO - Downloaded 1361 bytes. 05:49:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:27 INFO - Using the following test package requirements: 05:49:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'jsshell-linux-x86_64.zip'], 05:49:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:27 INFO - https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:29 INFO - Downloaded 24440058 bytes. 05:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:30 INFO - Return code: 0 05:49:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:30 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')]} 05:49:30 INFO - https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:34 INFO - Downloaded 24440058 bytes. 05:49:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:35 INFO - Return code: 0 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:36 INFO - Downloaded 10833369 bytes. 05:49:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:36 INFO - Return code: 0 05:49: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')]} 05:49:36 INFO - https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:38 INFO - Downloaded 59136071 bytes. 05:49:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:38 INFO - mkdir: /builds/slave/test/properties 05:49:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:38 INFO - Contents: 05:49:38 INFO - build_url:https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:39 INFO - Running post-action listener: _resource_record_post_action 05:49:39 INFO - Running post-action listener: set_extra_try_arguments 05:49:39 INFO - ##### 05:49:39 INFO - ##### Finished download-and-extract step (success) 05:49:39 INFO - ##### 05:49:39 INFO - ##### 05:49:39 INFO - ##### Running populate-webroot step. 05:49:39 INFO - ##### 05:49:39 INFO - Running pre-action listener: _resource_record_pre_action 05:49:39 INFO - Running main action method: populate_webroot 05:49:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:39 INFO - '--tppagecycles', 05:49:39 INFO - '7'], 05:49:39 INFO - 'tests': ['tsvgm']}}, 05:49:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['damp', 'tps']}, 05:49:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'tests': ['damp', 'tps']}, 05:49:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['dromaeo_dom']}, 05:49:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['a11yr', 05:49:39 INFO - 'ts_paint', 05:49:39 INFO - 'tpaint', 05:49:39 INFO - 'sessionrestore', 05:49:39 INFO - 'sessionrestore_no_auto_restore', 05:49:39 INFO - 'tabpaint']}, 05:49:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['tsvgx', 05:49:39 INFO - 'tsvgr_opacity', 05:49:39 INFO - 'tart', 05:49:39 INFO - 'tscrollx', 05:49:39 INFO - 'cart']}, 05:49:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:39 INFO - 'tsvgr_opacity', 05:49:39 INFO - 'tart', 05:49:39 INFO - 'tscrollx', 05:49:39 INFO - 'cart']}, 05:49:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'talos_options': ['--disable-e10s'], 05:49:39 INFO - 'tests': ['tp5o']}, 05:49:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'tests': ['tp5o']}, 05:49:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'talos_options': ['--disable-e10s', 05:49:39 INFO - '--xperf_path', 05:49:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:39 INFO - 'tests': ['tp5n']}, 05:49:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:39 INFO - 'talos_options': ['--xperf_path', 05:49:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:39 INFO - 'tests': ['tp5n']}}, 05:49:39 INFO - 'talos.zip': {'path': '', 05:49:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:39 INFO - Running post-action listener: _resource_record_post_action 05:49:39 INFO - ##### 05:49:39 INFO - ##### Finished populate-webroot step (success) 05:49:39 INFO - ##### 05:49:39 INFO - ##### 05:49:39 INFO - ##### Running create-virtualenv step. 05:49:39 INFO - ##### 05:49:39 INFO - Running pre-action listener: _resource_record_pre_action 05:49:39 INFO - Running main action method: create_virtualenv 05:49:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:39 INFO - Using real prefix '/usr' 05:49:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:41 INFO - Installing pip.................done. 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:41 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:42 INFO - Downloading/unpacking psutil>=3.1.1 05:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:44 INFO - Installing collected packages: psutil 05:49:44 INFO - Running setup.py install for psutil 05:49:44 INFO - building 'psutil._psutil_linux' extension 05:49:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:44 INFO - building 'psutil._psutil_posix' extension 05:49:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:44 INFO - Successfully installed psutil 05:49:44 INFO - Cleaning up... 05:49:44 INFO - Return code: 0 05:49:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:44 INFO - Using env: {'DISPLAY': ':0', 05:49:44 INFO - 'HOME': '/home/cltbld', 05:49:44 INFO - 'LANG': 'en_US.UTF-8', 05:49:44 INFO - 'LANGUAGE': 'en_US:en', 05:49:44 INFO - 'LOGNAME': 'cltbld', 05:49:44 INFO - 'MAIL': '/var/mail/cltbld', 05:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:44 INFO - 'MOZ_NO_REMOTE': '1', 05:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:44 INFO - 'NO_EM_RESTART': '1', 05:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:44 INFO - 'PWD': '/builds/slave/test', 05:49:44 INFO - 'SHELL': '/bin/bash', 05:49:44 INFO - 'SHLVL': '1', 05:49:44 INFO - 'TERM': 'linux', 05:49:44 INFO - 'TMOUT': '86400', 05:49:44 INFO - 'USER': 'cltbld', 05:49:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:44 INFO - '_': '/tools/buildbot/bin/python'} 05:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:46 INFO - Installing collected packages: mozsystemmonitor 05:49:46 INFO - Running setup.py install for mozsystemmonitor 05:49:46 INFO - Successfully installed mozsystemmonitor 05:49:46 INFO - Cleaning up... 05:49:47 INFO - Return code: 0 05:49:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 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 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:47 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 05:49:47 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 05:49:47 INFO - Using env: {'DISPLAY': ':0', 05:49:47 INFO - 'HOME': '/home/cltbld', 05:49:47 INFO - 'LANG': 'en_US.UTF-8', 05:49:47 INFO - 'LANGUAGE': 'en_US:en', 05:49:47 INFO - 'LOGNAME': 'cltbld', 05:49:47 INFO - 'MAIL': '/var/mail/cltbld', 05:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:47 INFO - 'MOZ_NO_REMOTE': '1', 05:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:47 INFO - 'NO_EM_RESTART': '1', 05:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:47 INFO - 'PWD': '/builds/slave/test', 05:49:47 INFO - 'SHELL': '/bin/bash', 05:49:47 INFO - 'SHLVL': '1', 05:49:47 INFO - 'TERM': 'linux', 05:49:47 INFO - 'TMOUT': '86400', 05:49:47 INFO - 'USER': 'cltbld', 05:49:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:47 INFO - '_': '/tools/buildbot/bin/python'} 05:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:49 INFO - warning: no files found matching '*.txt' 05:49:49 INFO - no previously-included directories found matching 'build' 05:49:49 INFO - no previously-included directories found matching 'dist' 05:49:49 INFO - no previously-included directories found matching '.git*' 05:49:49 INFO - Installing collected packages: jsonschema, functools32 05:49:49 INFO - Running setup.py install for functools32 05:49:49 INFO - warning: no files found matching '*.txt' 05:49:49 INFO - no previously-included directories found matching 'build' 05:49:49 INFO - no previously-included directories found matching 'dist' 05:49:49 INFO - no previously-included directories found matching '.git*' 05:49:49 INFO - Successfully installed jsonschema functools32 05:49:49 INFO - Cleaning up... 05:49:49 INFO - Return code: 0 05:49:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:49 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')]} 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:49 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')]} 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:49 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 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:49 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 05:49:49 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 05:49:49 INFO - Using env: {'DISPLAY': ':0', 05:49:49 INFO - 'HOME': '/home/cltbld', 05:49:49 INFO - 'LANG': 'en_US.UTF-8', 05:49:49 INFO - 'LANGUAGE': 'en_US:en', 05:49:49 INFO - 'LOGNAME': 'cltbld', 05:49:49 INFO - 'MAIL': '/var/mail/cltbld', 05:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:49 INFO - 'MOZ_NO_REMOTE': '1', 05:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:49 INFO - 'NO_EM_RESTART': '1', 05:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:49 INFO - 'PWD': '/builds/slave/test', 05:49:49 INFO - 'SHELL': '/bin/bash', 05:49:49 INFO - 'SHLVL': '1', 05:49:49 INFO - 'TERM': 'linux', 05:49:49 INFO - 'TMOUT': '86400', 05:49:49 INFO - 'USER': 'cltbld', 05:49:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:49 INFO - '_': '/tools/buildbot/bin/python'} 05:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 INFO - Downloading docopt-0.6.1.tar.gz 05:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:52 INFO - Running setup.py install for blobuploader 05:49:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:52 INFO - Running setup.py install for requests 05:49:52 INFO - Running setup.py install for docopt 05:49:52 INFO - Successfully installed blobuploader requests docopt 05:49:52 INFO - Cleaning up... 05:49:53 INFO - Return code: 0 05:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:53 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 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:53 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 05:49:53 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 05:49:53 INFO - Using env: {'DISPLAY': ':0', 05:49:53 INFO - 'HOME': '/home/cltbld', 05:49:53 INFO - 'LANG': 'en_US.UTF-8', 05:49:53 INFO - 'LANGUAGE': 'en_US:en', 05:49:53 INFO - 'LOGNAME': 'cltbld', 05:49:53 INFO - 'MAIL': '/var/mail/cltbld', 05:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:53 INFO - 'MOZ_NO_REMOTE': '1', 05:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:53 INFO - 'NO_EM_RESTART': '1', 05:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:53 INFO - 'PWD': '/builds/slave/test', 05:49:53 INFO - 'SHELL': '/bin/bash', 05:49:53 INFO - 'SHLVL': '1', 05:49:53 INFO - 'TERM': 'linux', 05:49:53 INFO - 'TMOUT': '86400', 05:49:53 INFO - 'USER': 'cltbld', 05:49:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:53 INFO - '_': '/tools/buildbot/bin/python'} 05:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:53 INFO - Running setup.py (path:/tmp/pip-hp7J1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:53 INFO - Running setup.py (path:/tmp/pip-Uo4MF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:53 INFO - Running setup.py (path:/tmp/pip-7Mslqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:53 INFO - Running setup.py (path:/tmp/pip-_OuZdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:53 INFO - Running setup.py (path:/tmp/pip-xGchdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:53 INFO - Running setup.py (path:/tmp/pip-oADaz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:53 INFO - Running setup.py (path:/tmp/pip-pX6xEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:53 INFO - Running setup.py (path:/tmp/pip-KylNkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:53 INFO - Running setup.py (path:/tmp/pip-Bic5nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:53 INFO - Running setup.py (path:/tmp/pip-ux3Ys2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:53 INFO - Running setup.py (path:/tmp/pip-kJcyZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:54 INFO - Running setup.py (path:/tmp/pip-7fKLTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:54 INFO - Running setup.py (path:/tmp/pip-OjSjHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:54 INFO - Running setup.py (path:/tmp/pip-IZPC0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:54 INFO - Running setup.py (path:/tmp/pip-l5MWa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:54 INFO - Running setup.py (path:/tmp/pip-Em_kBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:54 INFO - Running setup.py (path:/tmp/pip-lttPY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:54 INFO - Running setup.py install for manifestparser 05:49:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:54 INFO - Running setup.py install for mozcrash 05:49:54 INFO - Running setup.py install for mozdebug 05:49:54 INFO - Running setup.py install for mozdevice 05:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:54 INFO - Running setup.py install for mozfile 05:49:55 INFO - Running setup.py install for mozhttpd 05:49:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozinfo 05:49:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozInstall 05:49:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozleak 05:49:55 INFO - Running setup.py install for mozlog 05:49:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for moznetwork 05:49:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozprocess 05:49:55 INFO - Running setup.py install for mozprofile 05:49:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozrunner 05:49:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:55 INFO - Running setup.py install for mozscreenshot 05:49:56 INFO - Running setup.py install for moztest 05:49:56 INFO - Running setup.py install for mozversion 05:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:56 INFO - Cleaning up... 05:49:56 INFO - Return code: 0 05:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 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 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:49:56 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 05:49:56 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 05:49:56 INFO - Using env: {'DISPLAY': ':0', 05:49:56 INFO - 'HOME': '/home/cltbld', 05:49:56 INFO - 'LANG': 'en_US.UTF-8', 05:49:56 INFO - 'LANGUAGE': 'en_US:en', 05:49:56 INFO - 'LOGNAME': 'cltbld', 05:49:56 INFO - 'MAIL': '/var/mail/cltbld', 05:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:56 INFO - 'MOZ_NO_REMOTE': '1', 05:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:56 INFO - 'NO_EM_RESTART': '1', 05:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:56 INFO - 'PWD': '/builds/slave/test', 05:49:56 INFO - 'SHELL': '/bin/bash', 05:49:56 INFO - 'SHLVL': '1', 05:49:56 INFO - 'TERM': 'linux', 05:49:56 INFO - 'TMOUT': '86400', 05:49:56 INFO - 'USER': 'cltbld', 05:49:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:56 INFO - '_': '/tools/buildbot/bin/python'} 05:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:56 INFO - Running setup.py (path:/tmp/pip-l_hxml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:56 INFO - Running setup.py (path:/tmp/pip-cjA33d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:56 INFO - Running setup.py (path:/tmp/pip-wzCVuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:56 INFO - Running setup.py (path:/tmp/pip-C4yx_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:56 INFO - Running setup.py (path:/tmp/pip-wpFSfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:56 INFO - Running setup.py (path:/tmp/pip-3CP6w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:56 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)) 05:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:56 INFO - Running setup.py (path:/tmp/pip-5OCPpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:57 INFO - Running setup.py (path:/tmp/pip-4n4tzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:57 INFO - Running setup.py (path:/tmp/pip-agUwRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:57 INFO - Running setup.py (path:/tmp/pip-TUMqCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:57 INFO - Running setup.py (path:/tmp/pip-oexG8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:57 INFO - Running setup.py (path:/tmp/pip-_7ZXVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:57 INFO - Running setup.py (path:/tmp/pip-1XFvGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:57 INFO - Running setup.py (path:/tmp/pip-xQsUDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:57 INFO - Running setup.py (path:/tmp/pip-EvHkWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:57 INFO - Running setup.py (path:/tmp/pip-RKF3DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:57 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)) 05:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:57 INFO - Running setup.py (path:/tmp/pip-jU54My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:57 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)) 05:49:57 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)) 05:49:57 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)) 05:49:57 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)) 05:49:57 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)) 05:49:57 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)) 05:49:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - Downloading blessings-1.6.tar.gz 05:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:59 INFO - Installing collected packages: blessings 05:49:59 INFO - Running setup.py install for blessings 05:49:59 INFO - Successfully installed blessings 05:49:59 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:00 INFO - Reading from file tmpfile_stdout 05:50:00 INFO - Current package versions: 05:50:00 INFO - argparse == 1.2.1 05:50:00 INFO - blessings == 1.6 05:50:00 INFO - blobuploader == 1.2.4 05:50:00 INFO - docopt == 0.6.1 05:50:00 INFO - functools32 == 3.2.3-2 05:50:00 INFO - jsonschema == 2.5.1 05:50:00 INFO - manifestparser == 1.1 05:50:00 INFO - mozInstall == 1.12 05:50:00 INFO - mozcrash == 0.17 05:50:00 INFO - mozdebug == 0.1 05:50:00 INFO - mozdevice == 0.48 05:50:00 INFO - mozfile == 1.2 05:50:00 INFO - mozhttpd == 0.7 05:50:00 INFO - mozinfo == 0.9 05:50:00 INFO - mozleak == 0.1 05:50:00 INFO - mozlog == 3.2 05:50:00 INFO - moznetwork == 0.27 05:50:00 INFO - mozprocess == 0.22 05:50:00 INFO - mozprofile == 0.28 05:50:00 INFO - mozrunner == 6.11 05:50:00 INFO - mozscreenshot == 0.1 05:50:00 INFO - mozsystemmonitor == 0.3 05:50:00 INFO - moztest == 0.7 05:50:00 INFO - mozversion == 1.4 05:50:00 INFO - psutil == 3.1.1 05:50:00 INFO - requests == 1.2.3 05:50:00 INFO - wsgiref == 0.1.2 05:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 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 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:50:00 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 05:50:00 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 05:50:00 INFO - Using env: {'DISPLAY': ':0', 05:50:00 INFO - 'HOME': '/home/cltbld', 05:50:00 INFO - 'LANG': 'en_US.UTF-8', 05:50:00 INFO - 'LANGUAGE': 'en_US:en', 05:50:00 INFO - 'LOGNAME': 'cltbld', 05:50:00 INFO - 'MAIL': '/var/mail/cltbld', 05:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:00 INFO - 'MOZ_NO_REMOTE': '1', 05:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:00 INFO - 'NO_EM_RESTART': '1', 05:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:00 INFO - 'PWD': '/builds/slave/test', 05:50:00 INFO - 'SHELL': '/bin/bash', 05:50:00 INFO - 'SHLVL': '1', 05:50:00 INFO - 'TERM': 'linux', 05:50:00 INFO - 'TMOUT': '86400', 05:50:00 INFO - 'USER': 'cltbld', 05:50:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:00 INFO - '_': '/tools/buildbot/bin/python'} 05:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 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)) 05:50:00 INFO - Cleaning up... 05:50:00 INFO - Return code: 0 05:50:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:00 INFO - Using env: {'DISPLAY': ':0', 05:50:00 INFO - 'HOME': '/home/cltbld', 05:50:00 INFO - 'LANG': 'en_US.UTF-8', 05:50:00 INFO - 'LANGUAGE': 'en_US:en', 05:50:00 INFO - 'LOGNAME': 'cltbld', 05:50:00 INFO - 'MAIL': '/var/mail/cltbld', 05:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:00 INFO - 'MOZ_NO_REMOTE': '1', 05:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:00 INFO - 'NO_EM_RESTART': '1', 05:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:00 INFO - 'PWD': '/builds/slave/test', 05:50:00 INFO - 'SHELL': '/bin/bash', 05:50:00 INFO - 'SHLVL': '1', 05:50:00 INFO - 'TERM': 'linux', 05:50:00 INFO - 'TMOUT': '86400', 05:50:00 INFO - 'USER': 'cltbld', 05:50:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:00 INFO - '_': '/tools/buildbot/bin/python'} 05:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:00 INFO - Cleaning up... 05:50:00 INFO - Return code: 0 05:50:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f239a2a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', '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 05:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:50:00 INFO - Using env: {'DISPLAY': ':0', 05:50:00 INFO - 'HOME': '/home/cltbld', 05:50:00 INFO - 'LANG': 'en_US.UTF-8', 05:50:00 INFO - 'LANGUAGE': 'en_US:en', 05:50:00 INFO - 'LOGNAME': 'cltbld', 05:50:00 INFO - 'MAIL': '/var/mail/cltbld', 05:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:00 INFO - 'MOZ_NO_REMOTE': '1', 05:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:00 INFO - 'NO_EM_RESTART': '1', 05:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:00 INFO - 'PWD': '/builds/slave/test', 05:50:00 INFO - 'SHELL': '/bin/bash', 05:50:00 INFO - 'SHLVL': '1', 05:50:00 INFO - 'TERM': 'linux', 05:50:00 INFO - 'TMOUT': '86400', 05:50:00 INFO - 'USER': 'cltbld', 05:50:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:00 INFO - '_': '/tools/buildbot/bin/python'} 05:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:00 INFO - Downloading/unpacking flake8 05:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50:03 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 05:50:03 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 05:50:03 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 05:50:03 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 05:50:03 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 05:50:03 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 05:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:03 INFO - no previously-included directories found matching 'docs/_build' 05:50:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:03 INFO - Running setup.py install for pep8 05:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:03 INFO - no previously-included directories found matching 'docs/_build' 05:50:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:50:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:03 INFO - Cleaning up... 05:50:03 INFO - Return code: 0 05:50:03 INFO - Running post-action listener: _resource_record_post_action 05:50:03 INFO - Running post-action listener: _start_resource_monitoring 05:50:03 INFO - Starting resource monitoring. 05:50:03 INFO - ##### 05:50:03 INFO - ##### Finished create-virtualenv step (success) 05:50:03 INFO - ##### 05:50:03 INFO - ##### 05:50:03 INFO - ##### Running install step. 05:50:03 INFO - ##### 05:50:03 INFO - Running pre-action listener: _resource_record_pre_action 05:50:03 INFO - Running main action method: install 05:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:03 INFO - Reading from file tmpfile_stdout 05:50:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:03 INFO - Reading from file tmpfile_stdout 05:50:03 INFO - Output received: 05:50:03 INFO - Usage: mozinstall [options] installer 05:50:03 INFO - Options: 05:50:03 INFO - -h, --help show this help message and exit 05:50:03 INFO - -d DEST, --destination=DEST 05:50:03 INFO - Directory to install application into. [default: 05:50:03 INFO - "/builds/slave/test"] 05:50:03 INFO - --app=APP Application being installed. [default: firefox] 05:50:03 INFO - mkdir: /builds/slave/test/build/application 05:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:50:20 INFO - Reading from file tmpfile_stdout 05:50:20 INFO - Output received: 05:50:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:50:20 INFO - Running post-action listener: _resource_record_post_action 05:50:20 INFO - ##### 05:50:20 INFO - ##### Finished install step (success) 05:50:20 INFO - ##### 05:50:20 INFO - ##### 05:50:20 INFO - ##### Running run-tests step. 05:50:20 INFO - ##### 05:50:20 INFO - Running pre-action listener: _resource_record_pre_action 05:50:20 INFO - Running main action method: run_tests 05:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:20 INFO - Python 2.7.3 05:50:20 INFO - Return code: 0 05:50:20 INFO - grabbing minidump binary from tooltool 05:50: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')]} 05:50:20 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 0x2ab6110>, '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 0x2a22230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a226c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:20 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 05:50:20 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 05:50:20 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 05:50:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:20 INFO - Return code: 0 05:50:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:50:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:50:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:50:21 INFO - Return code: 0 05:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 05:50:21 INFO - Using env: {'DISPLAY': ':0', 05:50:21 INFO - 'HOME': '/home/cltbld', 05:50:21 INFO - 'LANG': 'en_US.UTF-8', 05:50:21 INFO - 'LANGUAGE': 'en_US:en', 05:50:21 INFO - 'LOGNAME': 'cltbld', 05:50:21 INFO - 'MAIL': '/var/mail/cltbld', 05:50:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:21 INFO - 'MOZ_NO_REMOTE': '1', 05:50:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:21 INFO - 'NO_EM_RESTART': '1', 05:50:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:21 INFO - 'PWD': '/builds/slave/test', 05:50:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:21 INFO - 'SHELL': '/bin/bash', 05:50:21 INFO - 'SHLVL': '1', 05:50:21 INFO - 'TERM': 'linux', 05:50:21 INFO - 'TMOUT': '86400', 05:50:21 INFO - 'USER': 'cltbld', 05:50:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905', 05:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:21 INFO - '_': '/tools/buildbot/bin/python'} 05:50:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:50:21 INFO - mozversion application_buildid: 20160603030242 05:50:21 INFO - mozversion application_changeset: e27fe24a746fa839f1cabe198faf1bad42c7dc4b 05:50:21 INFO - mozversion application_display_name: Nightly 05:50:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:21 INFO - mozversion application_name: Firefox 05:50:21 INFO - mozversion application_remotingname: firefox 05:50:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:21 INFO - mozversion application_vendor: Mozilla 05:50:21 INFO - mozversion application_version: 49.0a1 05:50:21 INFO - mozversion platform_buildid: 20160603030242 05:50:21 INFO - mozversion platform_changeset: e27fe24a746fa839f1cabe198faf1bad42c7dc4b 05:50:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:21 INFO - mozversion platform_version: 49.0a1 05:50:21 INFO - using testdate: 1464958221 05:50:21 INFO - actual date: 1464958221 05:50:21 INFO - starting webserver on 'localhost:46296' 05:50:21 INFO - SUITE-START | Running 2 tests 05:50:21 INFO - TEST-START | dromaeo_css 05:50:21 INFO - operating with platform_type : linux_ 05:50:21 INFO - Initialising browser for dromaeo_css test... 05:50:21 INFO - TEST-INFO | started process 4694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfuGR_M/profile http://localhost:46296/getInfo.html) 05:50:26 INFO - PROCESS | 4694 | __metrics Screen width/height:1600/1200 05:50:26 INFO - PROCESS | 4694 | colorDepth:24 05:50:26 INFO - PROCESS | 4694 | Browser inner width/height: 1024/697 05:50:26 INFO - PROCESS | 4694 | __metrics 05:50:26 ERROR - PROCESS | 4694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:50:27 INFO - TEST-INFO | 4694: exit 0 05:50:27 INFO - Browser initialized. 05:50:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:27 INFO - TEST-INFO | started process 4813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfuGR_M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:39 INFO - PROCESS | 4813 | RSS: Main: 167047168 05:50:39 INFO - PROCESS | 4813 | 05:51:29 INFO - PROCESS | 4813 | 1464958289257 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] 05:53:36 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46296/tests/dromaeo/cssquery-ext.html) 05:53:38 INFO - PROCESS | 4813 | RSS: Main: 170835968 05:53:38 INFO - PROCESS | 4813 | 05:56:40 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-ext.html (next: http://localhost:46296/tests/dromaeo/cssquery-jquery.html) 05:56:40 INFO - PROCESS | 4813 | RSS: Main: 170139648 05:56:40 INFO - PROCESS | 4813 | 05:59:42 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46296/tests/dromaeo/cssquery-mootools.html) 05:59:43 INFO - PROCESS | 4813 | RSS: Main: 171544576 05:59:43 INFO - PROCESS | 4813 | 06:02:45 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46296/tests/dromaeo/cssquery-prototype.html) 06:02:45 INFO - PROCESS | 4813 | RSS: Main: 169357312 06:02:45 INFO - PROCESS | 4813 | 06:05:48 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46296/tests/dromaeo/cssquery-yui.html) 06:05:48 INFO - PROCESS | 4813 | RSS: Main: 171237376 06:05:48 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-yui.html (next: http://localhost:46296/tests/dromaeo/cssquery-dojo.html) 06:08:51 INFO - PROCESS | 4813 | RSS: Main: 172072960 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | __start_tp_report 06:08:51 INFO - PROCESS | 4813 | _x_x_mozilla_page_load 06:08:51 INFO - PROCESS | 4813 | _x_x_mozilla_page_load_details 06:08:51 INFO - PROCESS | 4813 | |i|pagename|runs| 06:08:51 INFO - PROCESS | 4813 | |0;dojo.html;3093.8453077346135;3140.5446210299506;3157.8894738684153;3174.8571314290853;3186.9681303186962;5528.308961379827;5533.557315414767;5536.446355364462;5575.944240557593;5582.91625625615;5413.6389742053125;5416.51251387375;5446.183072539121;5473.67157970522;5555.777768889249;4882.633802464811;4912.778924948368;5007.7496125193775;5041.397244169023;5091.287219789232;945.7504771499478;4908.312836202935;4923.753812309388;5025.924611130836;5028.120078986181;4919.704817710913;4926.679765815246;4931.901361972758;4971.651984361096;5010.248462730601;4941;4966.031623833354;4974;4982.252662100677;5018.272350509155;4909.091818013679;4971.403431588196;4983;5003.2995380646735;5015.1474249377325;5392.379876314235;5404.297441332641;5405.567554595623;5418.349798024223;5435.320584926884;5673.517750991171;5838.970805145989;5852.912206316909;5890.941090589082;5920.348761636216;5821.50517206038;5841.912371314434;5871;5871.970640146772;5873.588848780587;5430.647007944471;5460.481254280837;5464.6994415307145;5486.094794358966;5489.945100548984;5805.912911306334;5903.26209223847;5954.821355359346;5973.04431291;5988.341282458926;5731.971340143273;5772.538196944319;5775.624584402;5781.19063331134;5816.5928385013485;5826.883462330729;5839.240898683144;5840.620359676607;5847.56143289255;5857.970710146422;5582.218489411485;5731.914021289684;5761.942380576224;5791.652500849962;5804.100364443518;5855.765769369263;5877.206577112035;5884.911726324109;5888.735006924699;5898.203742494794;4447.510773814878;4465.106978604292;4489.304157855538;4497.437820272466;4520.9095818084115;3932.6264004919485;3953.7627742335553;3975.185087057146;3981.7411868228473;3996.1208534122447;5491.28613280271;5494.835154945358;5505.669659820343;5519.668819870821;5552.5280351169795;5798.797042103591;5802.88394232113;5858.619189752652;5860.824175274749;5862.530997520188;5442.292501974718;5478.178273259043;5481.369642491165;5553.083741182741;5573.359063707644;4989.850304490871;5032.823851165192;5035.395752509722;5037.697738135724;5080.898382032338;5994.1608174855555;6042.244719410074;6047.365026672136;6052.788152414644;6053.424924632153;5921.851953701192;5992.161097446448;5996.010658241341;6034.155218269533;6039.214902062704;6145.846353841011;6203.4416902479;6205.007198848162;6205.410486003822;6211.3478084800445;5696.202531645656;5839.474447299764;5910.704464776658;5932;5943.346231914573;5977.103434484862;5985.952458319864;5998.430149135826;6005.099235114768;6066.241719785027;5840.94159058421;5855.707214639166;5870.148828419769;5872.0898260769645;5874.882502349844;5565.860853478695;5733.71331433435;5774.220480235114;5827.504662103769;5853.473187412983;5633.267675202197;5723.771049158154;5728.226689396878;5735.254416925773;5768.105943578752;5834.912476312774;5856.736446859987;5858.033424484912;5860.970695146497;5862.882742345215;5511.035568775368;5677.858053548694;5720.39935806751;5727.599068065362;5763.337216220189 06:08:51 INFO - PROCESS | 4813 | |1;ext.html;567.3872218004553;602.1118849696697;618.6442795392649;640.7789312687121;652.7747926965201;39007.60992390079;43281.78359108204;43427.56572434275;43586.56413435865;43622.78188609057;42827.14345713084;43465.34801977965;43480.782596087054;43495.34756978648;43517.56482435175;8717.259032982189;8870.645174193025;8873.20141187293;8915.153060459246;8917.197452229299;8748.387612867102;8788.8681669775;8823.77940551485;8827.33794965377;8832.249258812977;8812.603432845506;8869.68956086537;8870.689525866595;8883;8885.42244754089;8773.859398278215;8793.296536277083;8827.867581986275;8837.116288371144;8856;8678.218960293603;8790.912090879074;8794.076621954666;8817.955910220471;8821.911780882238;40352.39471407931;40403;40719.38920916188;40775.7961210195;40835;3551.804650744208;3773.603771603997;3786.318462676717;4144.772037537934;4248.893777655583;32061.51907721386;32223.838880805444;32396;32923.17692057694;32947.3410531788;4268.2743933531065;4309.849155279581;4359.17175736609;4413.117376524676;4483.708558943658;353176;353698;353797;354652;356096;59446.13600116065;59496.702516488;60126.09810852841;60224.69887650534;60480.69759651262;35591;61695.38304616986;62266;62622.68688656527;62623;15936.601584960468;16405.83594164043;16436.506904792874;16443.917780411022;16493.515583597295;11924.701882453008;11948.880511194951;11984.40077996114;12010.339431331186;12072.215306005082;19683.212671493267;19786.01069946497;19867.900660496605;19912.800871991094;19976.20095196176;7110.822229444305;7246.202917679051;7484.706729039205;7610.429217808686;7708.961455192688;958.6596758150756;973.5862258540234;976.7021058577202;1057.2493529593921;1145.9140564457698;32663.51477511572;32872.50691239633;33108.503372449435;33237.50143747846;33295.334093318;1108.6064447121155;1125.6735546691532;1215.6960759810047;1215.969600759988;1237.8947789437818;17299.962002279903;17557.561060973323;17623;17696.557586060193;17765.555861103578;605282;607789;612141;612283;612530;59485.107723384186;59651.40348596458;59669.403305966385;59790.70104649449;60047.39952600418;1297.3059413213884;1362.2303398579968;1373.4986729843736;1385.6951470676436;1389.833220013605;30555.2361190972;31934.52098218575;32159.51760723544;32341.514877277332;32782.18044548905;52605.21092183544;52652.21021684755;52772.472275276756;52889.20666190087;53187.46812531825;406539;413459;416182;417746;418281;28179;28209.294767630974;28385.29036774097;28513.28716782097;28539.143825685263;48427.660422478795;49153;49199;49615.50384496109;50528.74735626298;40416.3937540943;41801.372979404725;42849.571504284555;43102.78448607737;43473.34789978216;41786.37320440257;42174.78912605417;42427;42550.14899701927;42836.357454638826;41170.58829411787;44514.3322850151;44829.55170448254;45525.31712024256;45747;36310.8184459076;38341.079657342794;38592.80703596464;38901.416478752275;38903.80548097241;28745.425091497633;28942.42115157643;28950.855245723636;29140;29182.416351673273 06:08:51 INFO - PROCESS | 4813 | |2;jquery.html;385.5893473450773;389.55201518254023;392.3859160413952;398.66312965544114;413.02320013168844;17881.64236715265;19178.904105479487;19457.832530048207;19577;19964.201431942703;18958.526036849053;19249.422517324503;19591.902040489815;19629.90185049073;19642.410727678194;5424.864378390552;5640.605157638967;5653.604247702652;5710.257666503348;5863.472287494124;5554.50009499145;5635.267415236013;5640.971795141039;5684.8294551163535;5967.462928336449;5898.203742494751;5904.261967254093;5912.142739302799;5928.081147422156;5954.523638108963;5621.072523033695;5811.82564523065;5855.970720146414;5883.382244864292;5889.087191485327;5635.295588051494;5676.489115979582;5697.4587414195585;5718.485336319751;5722.599418040739;13671;19982.70025949612;22762.20332288362;22849.885750571142;22940.08239670411;2206.6910632511463;2211.2474427497887;2236.4520692430297;2251;2316.2587971849016;9505.857412138823;9600.423974561549;9772.471097545142;9942.652007179713;9995.550200241007;1934.7484826972545;1956.149075152299;1978;1994.4714650617598;2043.9080241389174;61057.64182969935;68746.65626671835;70615.2938470619;79271.20728792754;81801;10109.64616238428;10392.844107338396;10749.731256718645;10866.836997445045;10921.508532115915;15032.248387580577;15109.697806044038;15113.848861511464;15160.924195378953;15207.391704331923;7804.648790804314;8160.102388737234;8163.7142700005215;8321.417500774887;8417;7891.368690504861;8020.077691065486;8063.153368896299;8105.189481051848;8165.265126138676;4603.746793926299;4672.789724462407;4682.906341873144;4741.928871066937;4776.641751868624;1966.2135145941738;2000.5598768271248;2024.5647185855112;2046.2531176120906;2085.7705652378227;933.3326671429825;990.3612170150212;1010.545254635417;1043.9164866810636;1063.7553362726617;18293.268269269345;19034.428967131007;19253;19612.21551137967;19791.703124453146;996.8006398720285;999.9400035997863;1018.2617602238466;1047.8847326794046;1059.782744537368;10321.483925803679;10888.455577221266;10946;10961.561537538568;10967.83548246777;486153;501247;504999;506034;508468;76607;98065.50967245118;98416;101462;101625;1019.50553981319;1035.7514196592915;1036.1451802263164;1041.234692501011;1044.3994703045628;17675.558111047325;17910.283588656308;18095.819041809413;18102.45692629223;18297.45107646773;28455.146345609664;29186.7081329184;32604;42739.57260427481;43745.125097497235;60076.69961650164;60505.69747151236;60966.390336097844;61811.38188618056;62683.37316626775;8071.273585377344;8479.745607631781;8563.57182140878;8752.081031491856;8815.559222039;11885.940570297093;12966.546170883974;12969.286689232184;13308.201507909556;13415.865841341853;11197.384143872165;11343.886561134283;11520.423978801195;11561.537538498702;11652.766944661229;10941.179411544324;11569;11630.883691163319;11682.94158529202;11787.233829801036;11675.88324116782;11770.470328835052;11828.70428239301;11844;11882.346470944181;7284.526505777108;7673.923260767321;7737;7954.403419743427;8810.559472026245;11206.551737930718;11516.712082198012;11559.826602601135;11565.710857228636;11771.11716621274 06:08:51 INFO - PROCESS | 4813 | |3;mootools.html;1512.682336709291;1538.63072862513;1695.788026496688;1789.910504474776;1849.306510058728;8025.23760242776;8446.873296900552;8696.1303869613;9285;9296.628134874605;8447.366447516446;8656;8678.826423471543;8704.173103555167;8786.6924657637;2328.138588722171;2364.43253619131;2365.6924599802;2370.1941339944415;2380.059876348841;2333.195047708538;2367.9644805327935;2408.0608562660577;2429.4898071404937;2433.610622300432;2349.718033835942;2354.9646755298686;2358.2335740884196;2371.229350461107;2379.393254720044;2273.4771002669477;2275.1695631094613;2280.4184932842186;2282.82878784091;2315.988420057889;2208.5251670890834;2217.7782221777693;2227.576760415532;2228.5097278598682;2232.9888350558304;8709.477431354077;8720.694775682821;8764.992025917038;8766.474011559263;8823.955880220621;5123.052235336475;5184.533391994739;5211.635185537014;5216.739163041832;5219.556337711299;3379.3917094922904;3443.5523381960434;3562.893113206582;3591.102224443889;3598.442241452579;1130.8336657359362;1183.1422218891234;1187.1215300677522;1191.994040029803;1203.9759204815941;12188.756224875542;12349.753004939941;12444.502219911192;12456.81314780279;12535.56125535611;4647.488776234612;4675.953240467552;4765.880852978703;4766.404199475066;4766.928496072562;10558.894411055944;10576.206784491194;10588.523516441779;10593.629222977159;10629.627963021412;5369.812056578001;5376.973115134478;5416.052190866582;5425.403205647375;5426.403095659474;4414.84548040817;4800.615950723934;4848.757562121879;4974.602031837517;4975.427825800007;3860.864869729602;3959.6832253419657;3995.5405128410025;4036.8587099451966;4150.79246037703;1274.496094608371;1289.207137610363;1301.947922083106;1310.377570653951;1321.9933900330436;865.2256230673512;1018.8369860822232;1033.266380869576;1037.1391744851755;1038.9869876870143;6064.4238797315065;6235.594686345373;6235.625862448268;6263.906041409383;6330.746770129143;443.26860679878456;443.7027191781514;452.72383845854;453.62122627606317;458.43841294414744;4272.786360682016;4341.82632694695;4357.978210108992;4362.890927726832;4379.868603941887;10816.242862999672;11159.776804463865;11160.888391115985;11237.943810280896;11250.606228782117;10290;11072.446377681084;11150.49822757978;11162.162837787198;11193.608223712132;8055.879161812578;8393.6222869971;8411.116832732598;8438.240558349655;8468.745937621881;6011.398860113954;6210.161628180138;6245.7189426476825;6267.843303917256;6312.183821563894;9823.705288841345;9972.551235194289;9997.800043999225;10070.093691567794;10117.544710488193;10083.294169408071;10093;10093.243006774668;10152.898471015194;10208.081272685495;7886.132525422085;7915.327197188073;7999.120096789465;8036.116027237116;8057.0734365548715;8470.449420787629;8518.105598912025;8555.101714320155;8562.914370856211;8576.185262400062;7634.847303054019;7856.5678887661725;7912.32745216663;8069.193080691884;8070.757877263692;7517.586532740752;7546.811329716801;7743.7676869694;7744.225577442211;7867.567283799217;6712.496562757715;6740.932590674227;6805.115335006615;6837.384635382839;6851.657417129223;5171;5269.762860671202;5273.973630131824;5327;5389.730513474232;5064.392272927273;5238.947610523998;5376.946230537645;5465.863353416037;5482.17767334903 06:08:51 INFO - PROCESS | 4813 | |4;prototype.html;319.2354311424139;326.2187061986542;327.98524066417014;332.2292281905979;334.4064285892539;5402.78388864445;5561;5563.944360556398;5660.858478538039;5668.801591944288;5528.530074943625;5564.916526252109;5599.440055994399;5605.523530499912;5639.802606908759;4308.80610372534;4334.45819272591;4337.978310108445;4339.804708788112;4343.132453045189;4105.568915263899;4311.361682560622;4319.179355922381;4329.696921215516;4337.956620433787;4276.828926842923;4278.657707383401;4282.250606143913;4307.633851122659;4333.60997510224;4286.7139858042465;4304.677149213806;4304.870853874389;4321.135772845412;4325.437693099877;3565.23347480293;3767.6797472214894;3772.320982223199;3786.2995345860827;3801.448789925473;5283.365996080456;5315.3423288355825;5347.358317001985;5352.625316227865;5381.165919282517;4878.414590249157;4879.707217566922;4891.51084891508;4906.337644418029;4911.901761964741;5642.7178641067785;5772.769089236425;5800.651960882361;5802.883942321172;5845.941540584582;4077.184563087365;4091.6931230157857;4097.160082183145;4101.91796164078;4127.711060225785;5953.970230148865;6012.969935150296;6037.860312637448;6045.244344456943;6099.48154406876;3974.2250261198787;4166.416701661769;4191.580841915784;4203.43253660758;4229.519668116135;4279.807408666617;4282.571742825755;4294.720843145185;4304.78476076195;4312.7627980461375;4934.6545741798445;4941.555260026543;4943.283223932582;4945.010997800454;4966.90066198674;5724.370319264877;5884.58807883444;5967.776605795888;5986.5210783137245;5988.131720900445;1455.3596417576232;1473.963150921214;1474.2555009720238;1477.682298305848;1484.5546336099128;924.1545751537826;933.4446004627235;938.057252461272;954.9713508594754;956.4404823178519;5176.240078373371;5190.948090519122;5200.777817212952;5201.699575106223;5224.50367215114;5485.807996720096;5508.55931525477;5515.531179849758;5518.19986102021;5541.725403157297;4949.282354058641;5092.898142037213;5117;5121.8463446096675;5136;2838.545832666805;2870.7129287071543;2895.319599894023;2902.2889392099073;2903.50640391134;5532.585056120726;5563.13771365439;5575.247341608912;5607.943920560824;5656.349519805192;5138.845834624967;5375.3549574050585;5430.456954304538;5499.615026948155;5519.405879236752;5500.762328476061;5576.7211639417865;5600.831975040755;5628.917300598723;5672.914906276409;5082.796688132434;5222.791088356423;5436.184572314184;5456.972715136399;5486.369067557122;5268.552173065333;5272.78908843642;5335.719427337489;5345.33183352081;5346.732663366738;5517;5608.298962629671;5632.577556683347;5656.717164141859;5996.580239383201;3998.0804414984136;4149.27387707144;4151.584841515824;4158.750474971512;4164.12553363797;5963.589141672633;5965.433283838029;6021.698915054318;6028.819135425944;6080.2399700037495;5756.30924289088;5886.735096920564;5889.175515427758;5911.852203694942;5923.585349025527;5836.299644042742;5885.61743486672;5937.139114828412;5941.1385349125;5948.524118070457;5539.944600553943;5632.7183640816975;5687.289088863892;5729.8567535811935;5769.22115514417;5585.525230355465;5806.200077975841;5815.41845815415;5863.794767183128;5885.176075349369;5716.742746576331;5738.3071993761105;5758.3090029196765;5795.594308398372;5803.607134287825 06:08:51 INFO - PROCESS | 4813 | |5;yui.html;747.3236720767707;784.5057613703366;789.8894154818327;810.157436266283;837.401258100458;15309.693806123885;16502.174891255418;16595.253213605385;16670.416535421264;16741.079240641775;15007.774883376731;15350.232488375592;15426.69146617067;15429.768553471707;15483;679.4700133895569;801.3268854162502;815.3762371785574;836.113719457374;837.3301358912876;817.8732296494023;824.9546274954876;825.1707034430389;825.6160885188386;827.7061643116697;854.3336197765752;858.5063588436643;860.9612567434481;865.809521905183;865.9783505412352;854.799122206281;856.7900864288258;858.7295002074358;862.1593945902757;866.2030931542996;623.5385814497239;624.5846512069469;624.9062640603901;625.5808608232495;625.7559551774812;15240.847591524054;15279.388824447009;15322.463713769965;15334.769978450333;15353.232338383148;15207.543773686808;15833.445829395916;15943;16093.517194484184;16421.507354779376;12561.434735436927;12619.621411357673;12842.678933026657;12901.548445804445;13184.868151318557;3999.900002499932;4013.919721605581;4065.532463766675;4177.12280421112;4189.581041895816;79107.60446197732;79493.20506794917;81613;81667.5916620419;81689;12071.577494787816;12391.566295179626;12392.256464612152;12452.75094498105;12511.56209532662;23427.06291748311;23467;23535.17626883051;23650.4087397813;23673.28980130599;8885.955570222108;8915.509646969478;9072.591733372014;9226.769330766785;9311.06889311077;4530.977345113253;4795.95204047962;4845;4905.411350637946;5007.824726134568;3707.666310032056;3820.2550502651716;3844.59631738669;3848.749831260959;3856.82644281008;604.4861867412664;610.9663968481688;613.0620151168719;621.5369549685423;622.7944778223175;774.7714424244862;780.6877249100291;782.5383024015745;797.2824457987857;817.2032268538246;10509.106725928381;10527.473626318653;10587.417692027013;10705.46472676363;10710.625128120479;782.4288269563251;786.4809225910872;792.1167897793919;799.8400319936036;811.8051667599851;4935.432425271068;4997.375328083989;5014.548690617862;5029.371328583927;5050.671706339076;80029;117689.76171667902;119969.40015299867;125504;126550;68674.3132568668;81661.59169204115;84091;104836;105470;85106.57446712727;87311.56344218238;87541.56229218813;87747;88540.11459885447;9933.403995760278;10102.444365559964;10332.638357657446;10639.202059845697;10700.143988480748;47470;50248;51304.743476283875;51607.225891612405;52030;64832.6758366224;65988.34011659822;72003.63998179976;73426.63286683532;74186;12926.224426534438;13005.804912926504;13106.672333191747;13329.533466328632;13783.173009619455;15096.54710358647;15269.160196189316;15363.692726145639;15468.381264749283;15523.534293971199;14154.43382264739;14195.716085678436;14331.641708957359;14511.274436277932;14721.190334531275;14253.358598863284;14322.427102915766;14493.202873841617;14568.708625827212;14629.92685036568;13533.458661653423;13586.592402227949;13798.862011379757;13847.723045539235;14020.719585608027;11602.47788849487;11672.824907626222;11746.29522228669;11882.584109556125;12257.448414821532;11665.183437159318;11815.527378904748;11877.584284550345;11953.581624643095;12087.576934807239 06:08:51 INFO - PROCESS | 4813 | __end_tp_report 06:08:51 INFO - PROCESS | 4813 | __start_cc_report 06:08:51 INFO - PROCESS | 4813 | _x_x_mozilla_cycle_collect,358 06:08:51 INFO - PROCESS | 4813 | __end_cc_report 06:08:51 INFO - PROCESS | 4813 | __startTimestamp1464959331550__endTimestamp 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | ------- Summary: start ------- 06:08:51 INFO - PROCESS | 4813 | Number of tests: 6 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#0] dojo.html Cycles:165 Average:5432.04 Median:5723.77 stddev:725.57 (12.7%) stddev-sans-first:704.22 06:08:51 INFO - PROCESS | 4813 | Values: 3093.8 3140.5 3157.9 3174.9 3187.0 5528.3 5533.6 5536.4 5575.9 5582.9 5413.6 5416.5 5446.2 5473.7 5555.8 4882.6 4912.8 5007.7 5041.4 5091.3 945.8 4908.3 4923.8 5025.9 5028.1 4919.7 4926.7 4931.9 4971.7 5010.2 4941.0 4966.0 4974.0 4982.3 5018.3 4909.1 4971.4 4983.0 5003.3 5015.1 5392.4 5404.3 5405.6 5418.3 5435.3 5673.5 5839.0 5852.9 5890.9 5920.3 5821.5 5841.9 5871.0 5872.0 5873.6 5430.6 5460.5 5464.7 5486.1 5489.9 5805.9 5903.3 5954.8 5973.0 5988.3 5732.0 5772.5 5775.6 5781.2 5816.6 5826.9 5839.2 5840.6 5847.6 5858.0 5582.2 5731.9 5761.9 5791.7 5804.1 5855.8 5877.2 5884.9 5888.7 5898.2 4447.5 4465.1 4489.3 4497.4 4520.9 3932.6 3953.8 3975.2 3981.7 3996.1 5491.3 5494.8 5505.7 5519.7 5552.5 5798.8 5802.9 5858.6 5860.8 5862.5 5442.3 5478.2 5481.4 5553.1 5573.4 4989.9 5032.8 5035.4 5037.7 5080.9 5994.2 6042.2 6047.4 6052.8 6053.4 5921.9 5992.2 5996.0 6034.2 6039.2 6145.8 6203.4 6205.0 6205.4 6211.3 5696.2 5839.5 5910.7 5932.0 5943.3 5977.1 5986.0 5998.4 6005.1 6066.2 5840.9 5855.7 5870.1 5872.1 5874.9 5565.9 5733.7 5774.2 5827.5 5853.5 5633.3 5723.8 5728.2 5735.3 5768.1 5834.9 5856.7 5858.0 5861.0 5862.9 5511.0 5677.9 5720.4 5727.6 5763.3 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#1] ext.html Cycles:180 Average:62111.66 Median:23409.21 stddev:125633.40 (536.7%) stddev-sans-first:125900.86 06:08:51 INFO - PROCESS | 4813 | Values: 567.4 602.1 618.6 640.8 652.8 39007.6 43281.8 43427.6 43586.6 43622.8 42827.1 43465.3 43480.8 43495.3 43517.6 8717.3 8870.6 8873.2 8915.2 8917.2 8748.4 8788.9 8823.8 8827.3 8832.2 8812.6 8869.7 8870.7 8883.0 8885.4 8773.9 8793.3 8827.9 8837.1 8856.0 8678.2 8790.9 8794.1 8818.0 8821.9 40352.4 40403.0 40719.4 40775.8 40835.0 3551.8 3773.6 3786.3 4144.8 4248.9 32061.5 32223.8 32396.0 32923.2 32947.3 4268.3 4309.8 4359.2 4413.1 4483.7 353176.0 353698.0 353797.0 354652.0 356096.0 59446.1 59496.7 60126.1 60224.7 60480.7 35591.0 61695.4 62266.0 62622.7 62623.0 15936.6 16405.8 16436.5 16443.9 16493.5 11924.7 11948.9 11984.4 12010.3 12072.2 19683.2 19786.0 19867.9 19912.8 19976.2 7110.8 7246.2 7484.7 7610.4 7709.0 958.7 973.6 976.7 1057.2 1145.9 32663.5 32872.5 33108.5 33237.5 33295.3 1108.6 1125.7 1215.7 1216.0 1237.9 17300.0 17557.6 17623.0 17696.6 17765.6 605282.0 607789.0 612141.0 612283.0 612530.0 59485.1 59651.4 59669.4 59790.7 60047.4 1297.3 1362.2 1373.5 1385.7 1389.8 30555.2 31934.5 32159.5 32341.5 32782.2 52605.2 52652.2 52772.5 52889.2 53187.5 406539.0 413459.0 416182.0 417746.0 418281.0 28179.0 28209.3 28385.3 28513.3 28539.1 48427.7 49153.0 49199.0 49615.5 50528.7 40416.4 41801.4 42849.6 43102.8 43473.3 41786.4 42174.8 42427.0 42550.1 42836.4 41170.6 44514.3 44829.6 45525.3 45747.0 36310.8 38341.1 38592.8 38901.4 38903.8 28745.4 28942.4 28950.9 29140.0 29182.4 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#2] jquery.html Cycles:180 Average:28975.32 Median:22894.98 stddev:82607.98 (360.8%) stddev-sans-first:82811.82 06:08:51 INFO - PROCESS | 4813 | Values: 385.6 389.6 392.4 398.7 413.0 17881.6 19178.9 19457.8 19577.0 19964.2 18958.5 19249.4 19591.9 19629.9 19642.4 5424.9 5640.6 5653.6 5710.3 5863.5 5554.5 5635.3 5641.0 5684.8 5967.5 5898.2 5904.3 5912.1 5928.1 5954.5 5621.1 5811.8 5856.0 5883.4 5889.1 5635.3 5676.5 5697.5 5718.5 5722.6 13671.0 19982.7 22762.2 22849.9 22940.1 2206.7 2211.2 2236.5 2251.0 2316.3 9505.9 9600.4 9772.5 9942.7 9995.6 1934.7 1956.1 1978.0 1994.5 2043.9 61057.6 68746.7 70615.3 79271.2 81801.0 10109.6 10392.8 10749.7 10866.8 10921.5 15032.2 15109.7 15113.8 15160.9 15207.4 7804.6 8160.1 8163.7 8321.4 8417.0 7891.4 8020.1 8063.2 8105.2 8165.3 4603.7 4672.8 4682.9 4741.9 4776.6 1966.2 2000.6 2024.6 2046.3 2085.8 933.3 990.4 1010.5 1043.9 1063.8 18293.3 19034.4 19253.0 19612.2 19791.7 996.8 999.9 1018.3 1047.9 1059.8 10321.5 10888.5 10946.0 10961.6 10967.8 486153.0 501247.0 504999.0 506034.0 508468.0 76607.0 98065.5 98416.0 101462.0 101625.0 1019.5 1035.8 1036.1 1041.2 1044.4 17675.6 17910.3 18095.8 18102.5 18297.5 28455.1 29186.7 32604.0 42739.6 43745.1 60076.7 60505.7 60966.4 61811.4 62683.4 8071.3 8479.7 8563.6 8752.1 8815.6 11885.9 12966.5 12969.3 13308.2 13415.9 11197.4 11343.9 11520.4 11561.5 11652.8 10941.2 11569.0 11630.9 11682.9 11787.2 11675.9 11770.5 11828.7 11844.0 11882.3 7284.5 7673.9 7737.0 7954.4 8810.6 11206.6 11516.7 11559.8 11565.7 11771.1 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#3] mootools.html Cycles:180 Average:5857.75 Median:456.03 stddev:3327.89 (729.8%) stddev-sans-first:3321.20 06:08:51 INFO - PROCESS | 4813 | Values: 1512.7 1538.6 1695.8 1789.9 1849.3 8025.2 8446.9 8696.1 9285.0 9296.6 8447.4 8656.0 8678.8 8704.2 8786.7 2328.1 2364.4 2365.7 2370.2 2380.1 2333.2 2368.0 2408.1 2429.5 2433.6 2349.7 2355.0 2358.2 2371.2 2379.4 2273.5 2275.2 2280.4 2282.8 2316.0 2208.5 2217.8 2227.6 2228.5 2233.0 8709.5 8720.7 8765.0 8766.5 8824.0 5123.1 5184.5 5211.6 5216.7 5219.6 3379.4 3443.6 3562.9 3591.1 3598.4 1130.8 1183.1 1187.1 1192.0 1204.0 12188.8 12349.8 12444.5 12456.8 12535.6 4647.5 4676.0 4765.9 4766.4 4766.9 10558.9 10576.2 10588.5 10593.6 10629.6 5369.8 5377.0 5416.1 5425.4 5426.4 4414.8 4800.6 4848.8 4974.6 4975.4 3860.9 3959.7 3995.5 4036.9 4150.8 1274.5 1289.2 1301.9 1310.4 1322.0 865.2 1018.8 1033.3 1037.1 1039.0 6064.4 6235.6 6235.6 6263.9 6330.7 443.3 443.7 452.7 453.6 458.4 4272.8 4341.8 4358.0 4362.9 4379.9 10816.2 11159.8 11160.9 11237.9 11250.6 10290.0 11072.4 11150.5 11162.2 11193.6 8055.9 8393.6 8411.1 8438.2 8468.7 6011.4 6210.2 6245.7 6267.8 6312.2 9823.7 9972.6 9997.8 10070.1 10117.5 10083.3 10093.0 10093.2 10152.9 10208.1 7886.1 7915.3 7999.1 8036.1 8057.1 8470.4 8518.1 8555.1 8562.9 8576.2 7634.8 7856.6 7912.3 8069.2 8070.8 7517.6 7546.8 7743.8 7744.2 7867.6 6712.5 6740.9 6805.1 6837.4 6851.7 5171.0 5269.8 5274.0 5327.0 5389.7 5064.4 5238.9 5376.9 5465.9 5482.2 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#4] prototype.html Cycles:180 Average:4750.74 Median:5349.99 stddev:1387.06 (25.9%) stddev-sans-first:1350.48 06:08:51 INFO - PROCESS | 4813 | Values: 319.2 326.2 328.0 332.2 334.4 5402.8 5561.0 5563.9 5660.9 5668.8 5528.5 5564.9 5599.4 5605.5 5639.8 4308.8 4334.5 4338.0 4339.8 4343.1 4105.6 4311.4 4319.2 4329.7 4338.0 4276.8 4278.7 4282.3 4307.6 4333.6 4286.7 4304.7 4304.9 4321.1 4325.4 3565.2 3767.7 3772.3 3786.3 3801.4 5283.4 5315.3 5347.4 5352.6 5381.2 4878.4 4879.7 4891.5 4906.3 4911.9 5642.7 5772.8 5800.7 5802.9 5845.9 4077.2 4091.7 4097.2 4101.9 4127.7 5954.0 6013.0 6037.9 6045.2 6099.5 3974.2 4166.4 4191.6 4203.4 4229.5 4279.8 4282.6 4294.7 4304.8 4312.8 4934.7 4941.6 4943.3 4945.0 4966.9 5724.4 5884.6 5967.8 5986.5 5988.1 1455.4 1474.0 1474.3 1477.7 1484.6 924.2 933.4 938.1 955.0 956.4 5176.2 5190.9 5200.8 5201.7 5224.5 5485.8 5508.6 5515.5 5518.2 5541.7 4949.3 5092.9 5117.0 5121.8 5136.0 2838.5 2870.7 2895.3 2902.3 2903.5 5532.6 5563.1 5575.2 5607.9 5656.3 5138.8 5375.4 5430.5 5499.6 5519.4 5500.8 5576.7 5600.8 5628.9 5672.9 5082.8 5222.8 5436.2 5457.0 5486.4 5268.6 5272.8 5335.7 5345.3 5346.7 5517.0 5608.3 5632.6 5656.7 5996.6 3998.1 4149.3 4151.6 4158.8 4164.1 5963.6 5965.4 6021.7 6028.8 6080.2 5756.3 5886.7 5889.2 5911.9 5923.6 5836.3 5885.6 5937.1 5941.1 5948.5 5539.9 5632.7 5687.3 5729.9 5769.2 5585.5 5806.2 5815.4 5863.8 5885.2 5716.7 5738.3 5758.3 5795.6 5803.6 06:08:51 INFO - PROCESS | 4813 | 06:08:51 INFO - PROCESS | 4813 | [#5] yui.html Cycles:180 Average:20908.91 Median:4006.91 stddev:29340.32 (732.2%) stddev-sans-first:29383.57 06:08:51 INFO - PROCESS | 4813 | Values: 747.3 784.5 789.9 810.2 837.4 15309.7 16502.2 16595.3 16670.4 16741.1 15007.8 15350.2 15426.7 15429.8 15483.0 679.5 801.3 815.4 836.1 837.3 817.9 825.0 825.2 825.6 827.7 854.3 858.5 861.0 865.8 866.0 854.8 856.8 858.7 862.2 866.2 623.5 624.6 624.9 625.6 625.8 15240.8 15279.4 15322.5 15334.8 15353.2 15207.5 15833.4 15943.0 16093.5 16421.5 12561.4 12619.6 12842.7 12901.5 13184.9 3999.9 4013.9 4065.5 4177.1 4189.6 79107.6 79493.2 81613.0 81667.6 81689.0 12071.6 12391.6 12392.3 12452.8 12511.6 23427.1 23467.0 23535.2 23650.4 23673.3 8886.0 8915.5 9072.6 9226.8 9311.1 4531.0 4796.0 4845.0 4905.4 5007.8 3707.7 3820.3 3844.6 3848.7 3856.8 604.5 611.0 613.1 621.5 622.8 774.8 780.7 782.5 797.3 817.2 10509.1 10527.5 10587.4 10705.5 10710.6 782.4 786.5 792.1 799.8 811.8 4935.4 4997.4 5014.5 5029.4 5050.7 80029.0 117689.8 119969.4 125504.0 126550.0 68674.3 81661.6 84091.0 104836.0 105470.0 85106.6 87311.6 87541.6 87747.0 88540.1 9933.4 10102.4 10332.6 10639.2 10700.1 47470.0 50248.0 51304.7 51607.2 52030.0 64832.7 65988.3 72003.6 73426.6 74186.0 12926.2 13005.8 13106.7 13329.5 13783.2 15096.5 15269.2 15363.7 15468.4 15523.5 14154.4 14195.7 14331.6 14511.3 14721.2 14253.4 14322.4 14493.2 14568.7 14629.9 13533.5 13586.6 13798.9 13847.7 14020.7 11602.5 11672.8 11746.3 11882.6 12257.4 11665.2 11815.5 11877.6 11953.6 12087.6 06:08:51 INFO - PROCESS | 4813 | -------- Summary: end -------- 06:08:51 INFO - PROCESS | 4813 | 06:08:52 INFO - TEST-INFO | 4813: exit 0 06:08:52 INFO - TEST-OK | dromaeo_css | took 1110292ms 06:08:52 INFO - TEST-START | kraken 06:08:52 INFO - operating with platform_type : linux_ 06:08:52 INFO - Initialising browser for kraken test... 06:08:52 INFO - TEST-INFO | started process 5049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCBDYiv/profile http://localhost:46296/getInfo.html) 06:08:56 INFO - PROCESS | 5049 | __metrics Screen width/height:1600/1200 06:08:56 INFO - PROCESS | 5049 | colorDepth:24 06:08:56 INFO - PROCESS | 5049 | Browser inner width/height: 1024/697 06:08:56 INFO - PROCESS | 5049 | __metrics 06:08:57 ERROR - PROCESS | 5049 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:08:57 INFO - TEST-INFO | 5049: exit 0 06:08:57 INFO - Browser initialized. 06:08:57 INFO - Running cycle 1/1 for kraken test... 06:08:57 INFO - TEST-INFO | started process 5166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCBDYiv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:09 INFO - PROCESS | 5166 | RSS: Main: 167337984 06:09:09 INFO - PROCESS | 5166 | 06:09:12 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:13 INFO - PROCESS | 5166 | RSS: Main: 172810240 06:09:13 INFO - PROCESS | 5166 | 06:09:15 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-dft) 06:09:16 INFO - PROCESS | 5166 | RSS: Main: 172122112 06:09:16 INFO - PROCESS | 5166 | 06:09:19 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-fft) 06:09:19 INFO - PROCESS | 5166 | RSS: Main: 166723584 06:09:19 INFO - PROCESS | 5166 | 06:09:22 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-oscillator) 06:09:22 INFO - PROCESS | 5166 | RSS: Main: 167460864 06:09:22 INFO - PROCESS | 5166 | 06:09:25 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:25 INFO - PROCESS | 5166 | RSS: Main: 167854080 06:09:25 INFO - PROCESS | 5166 | 06:09:28 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:29 INFO - PROCESS | 5166 | RSS: Main: 168157184 06:09:29 INFO - PROCESS | 5166 | 06:09:32 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:33 INFO - PROCESS | 5166 | RSS: Main: 168869888 06:09:33 INFO - PROCESS | 5166 | 06:09:36 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46296/tests/kraken/driver.html?testName=json-parse-financial) 06:09:36 INFO - PROCESS | 5166 | RSS: Main: 168710144 06:09:36 INFO - PROCESS | 5166 | 06:09:38 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:39 INFO - PROCESS | 5166 | RSS: Main: 168894464 06:09:39 INFO - PROCESS | 5166 | 06:09:40 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:41 INFO - PROCESS | 5166 | RSS: Main: 168947712 06:09:41 INFO - PROCESS | 5166 | 06:09:43 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:44 INFO - PROCESS | 5166 | RSS: Main: 169201664 06:09:44 INFO - PROCESS | 5166 | 06:09:46 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:47 INFO - PROCESS | 5166 | RSS: Main: 169287680 06:09:47 INFO - PROCESS | 5166 | 06:09:50 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:50 INFO - PROCESS | 5166 | RSS: Main: 168726528 06:09:50 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46296/tests/kraken/driver.html?testName=ai-astar) 06:09:52 INFO - PROCESS | 5166 | RSS: Main: 169439232 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | __start_tp_report 06:09:52 INFO - PROCESS | 5166 | _x_x_mozilla_page_load 06:09:52 INFO - PROCESS | 5166 | _x_x_mozilla_page_load_details 06:09:52 INFO - PROCESS | 5166 | |i|pagename|runs| 06:09:52 INFO - PROCESS | 5166 | |0;ai-astar;110;105;110;110;111;113;109;110;110;110 06:09:52 INFO - PROCESS | 5166 | |1;audio-beat-detection;157;127;163;191;127;163;159;127;192;128 06:09:52 INFO - PROCESS | 5166 | |2;audio-dft;162;162;166;162;162;164;172;164;164;163 06:09:52 INFO - PROCESS | 5166 | |3;audio-fft;76;76;76;159;75;75;74;77;167;76 06:09:52 INFO - PROCESS | 5166 | |4;audio-oscillator;85;84;145;85;85;86;141;85;85;146 06:09:52 INFO - PROCESS | 5166 | |5;imaging-gaussian-blur;119;117;117;117;118;117;118;117;117;117 06:09:52 INFO - PROCESS | 5166 | |6;imaging-darkroom;146;148;146;148;147;146;148;146;146;146 06:09:52 INFO - PROCESS | 5166 | |7;imaging-desaturate;97;95;95;96;96;95;96;96;98;96 06:09:52 INFO - PROCESS | 5166 | |8;json-parse-financial;53;54;52;53;55;52;54;53;52;51 06:09:52 INFO - PROCESS | 5166 | |9;json-stringify-tinderbox;63;63;65;63;63;63;63;63;63;63 06:09:52 INFO - PROCESS | 5166 | |10;stanford-crypto-aes;87;79;80;80;81;81;82;80;110;80 06:09:52 INFO - PROCESS | 5166 | |11;stanford-crypto-ccm;136;122;135;133;124;133;127;126;138;136 06:09:52 INFO - PROCESS | 5166 | |12;stanford-crypto-pbkdf2;162;157;163;163;164;158;164;160;158;160 06:09:52 INFO - PROCESS | 5166 | |13;stanford-crypto-sha256-iterative;65;64;63;62;64;67;62;63;65;62 06:09:52 INFO - PROCESS | 5166 | __end_tp_report 06:09:52 INFO - PROCESS | 5166 | __start_cc_report 06:09:52 INFO - PROCESS | 5166 | _x_x_mozilla_cycle_collect,872 06:09:52 INFO - PROCESS | 5166 | __end_cc_report 06:09:52 INFO - PROCESS | 5166 | __startTimestamp1464959392739__endTimestamp 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | ------- Summary: start ------- 06:09:52 INFO - PROCESS | 5166 | Number of tests: 14 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.99 (1.8%) stddev-sans-first:2.11 06:09:52 INFO - PROCESS | 5166 | Values: 110.0 105.0 110.0 110.0 111.0 113.0 109.0 110.0 110.0 110.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:161.00 stddev:25.54 (15.9%) stddev-sans-first:27.05 06:09:52 INFO - PROCESS | 5166 | Values: 157.0 127.0 163.0 191.0 127.0 163.0 159.0 127.0 192.0 128.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.07 (1.9%) stddev-sans-first:3.16 06:09:52 INFO - PROCESS | 5166 | Values: 162.0 162.0 166.0 162.0 162.0 164.0 172.0 164.0 164.0 163.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.90 (48.5%) stddev-sans-first:38.61 06:09:52 INFO - PROCESS | 5166 | Values: 76.0 76.0 76.0 159.0 75.0 75.0 74.0 77.0 167.0 76.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.53 (33.6%) stddev-sans-first:29.53 06:09:52 INFO - PROCESS | 5166 | Values: 85.0 84.0 145.0 85.0 85.0 86.0 141.0 85.0 85.0 146.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 06:09:52 INFO - PROCESS | 5166 | Values: 119.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:09:52 INFO - PROCESS | 5166 | Values: 146.0 148.0 146.0 148.0 147.0 146.0 148.0 146.0 146.0 146.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 06:09:52 INFO - PROCESS | 5166 | Values: 97.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 98.0 96.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 06:09:52 INFO - PROCESS | 5166 | Values: 53.0 54.0 52.0 53.0 55.0 52.0 54.0 53.0 52.0 51.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:09:52 INFO - PROCESS | 5166 | Values: 63.0 63.0 65.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:80.50 stddev:9.40 (11.7%) stddev-sans-first:9.91 06:09:52 INFO - PROCESS | 5166 | Values: 87.0 79.0 80.0 80.0 81.0 81.0 82.0 80.0 110.0 80.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:134.00 stddev:5.72 (4.3%) stddev-sans-first:5.77 06:09:52 INFO - PROCESS | 5166 | Values: 136.0 122.0 135.0 133.0 124.0 133.0 127.0 126.0 138.0 136.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.50 stddev:2.64 (1.6%) stddev-sans-first:2.77 06:09:52 INFO - PROCESS | 5166 | Values: 162.0 157.0 163.0 163.0 164.0 158.0 164.0 160.0 158.0 160.0 06:09:52 INFO - PROCESS | 5166 | 06:09:52 INFO - PROCESS | 5166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.64 (2.6%) stddev-sans-first:1.67 06:09:52 INFO - PROCESS | 5166 | Values: 65.0 64.0 63.0 62.0 64.0 67.0 62.0 63.0 65.0 62.0 06:09:52 INFO - PROCESS | 5166 | -------- Summary: end -------- 06:09:52 INFO - PROCESS | 5166 | 06:09:53 INFO - TEST-INFO | 5166: exit 0 06:09:53 INFO - TEST-OK | kraken | took 61388ms 06:09:53 INFO - SUITE-END | took 1171s 06:09:53 INFO - Completed test suite (00:19:31) 06:09:53 INFO - javascript benchmark 06:09:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7343.247577988068, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.8453077346135, 3140.5446210299506, 3157.8894738684153, 3174.8571314290853, 3186.9681303186962, 5528.308961379827, 5533.557315414767, 5536.446355364462, 5575.944240557593, 5582.91625625615, 5413.6389742053125, 5416.51251387375, 5446.183072539121, 5473.67157970522, 5555.777768889249, 4882.633802464811, 4912.778924948368, 5007.7496125193775, 5041.397244169023, 5091.287219789232, 945.7504771499478, 4908.312836202935, 4923.753812309388, 5025.924611130836, 5028.120078986181, 4919.704817710913, 4926.679765815246, 4931.901361972758, 4971.651984361096, 5010.248462730601, 4941.0, 4966.031623833354, 4974.0, 4982.252662100677, 5018.272350509155, 4909.091818013679, 4971.403431588196, 4983.0, 5003.2995380646735, 5015.1474249377325, 5392.379876314235, 5404.297441332641, 5405.567554595623, 5418.349798024223, 5435.320584926884, 5673.517750991171, 5838.970805145989, 5852.912206316909, 5890.941090589082, 5920.348761636216, 5821.50517206038, 5841.912371314434, 5871.0, 5871.970640146772, 5873.588848780587, 5430.647007944471, 5460.481254280837, 5464.6994415307145, 5486.094794358966, 5489.945100548984, 5805.912911306334, 5903.26209223847, 5954.821355359346, 5973.04431291, 5988.341282458926, 5731.971340143273, 5772.538196944319, 5775.624584402, 5781.19063331134, 5816.5928385013485, 5826.883462330729, 5839.240898683144, 5840.620359676607, 5847.56143289255, 5857.970710146422, 5582.218489411485, 5731.914021289684, 5761.942380576224, 5791.652500849962, 5804.100364443518, 5855.765769369263, 5877.206577112035, 5884.911726324109, 5888.735006924699, 5898.203742494794, 4447.510773814878, 4465.106978604292, 4489.304157855538, 4497.437820272466, 4520.9095818084115, 3932.6264004919485, 3953.7627742335553, 3975.185087057146, 3981.7411868228473, 3996.1208534122447, 5491.28613280271, 5494.835154945358, 5505.669659820343, 5519.668819870821, 5552.5280351169795, 5798.797042103591, 5802.88394232113, 5858.619189752652, 5860.824175274749, 5862.530997520188, 5442.292501974718, 5478.178273259043, 5481.369642491165, 5553.083741182741, 5573.359063707644, 4989.850304490871, 5032.823851165192, 5035.395752509722, 5037.697738135724, 5080.898382032338, 5994.1608174855555, 6042.244719410074, 6047.365026672136, 6052.788152414644, 6053.424924632153, 5921.851953701192, 5992.161097446448, 5996.010658241341, 6034.155218269533, 6039.214902062704, 6145.846353841011, 6203.4416902479, 6205.007198848162, 6205.410486003822, 6211.3478084800445, 5696.202531645656, 5839.474447299764, 5910.704464776658, 5932.0, 5943.346231914573, 5977.103434484862, 5985.952458319864, 5998.430149135826, 6005.099235114768, 6066.241719785027, 5840.94159058421, 5855.707214639166, 5870.148828419769, 5872.0898260769645, 5874.882502349844, 5565.860853478695, 5733.71331433435, 5774.220480235114, 5827.504662103769, 5853.473187412983, 5633.267675202197, 5723.771049158154, 5728.226689396878, 5735.254416925773, 5768.105943578752, 5834.912476312774, 5856.736446859987, 5858.033424484912, 5860.970695146497, 5862.882742345215, 5511.035568775368, 5677.858053548694, 5720.39935806751, 5727.599068065362, 5763.337216220189], "value": 5383.45082580973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3872218004553, 602.1118849696697, 618.6442795392649, 640.7789312687121, 652.7747926965201, 39007.60992390079, 43281.78359108204, 43427.56572434275, 43586.56413435865, 43622.78188609057, 42827.14345713084, 43465.34801977965, 43480.782596087054, 43495.34756978648, 43517.56482435175, 8717.259032982189, 8870.645174193025, 8873.20141187293, 8915.153060459246, 8917.197452229299, 8748.387612867102, 8788.8681669775, 8823.77940551485, 8827.33794965377, 8832.249258812977, 8812.603432845506, 8869.68956086537, 8870.689525866595, 8883.0, 8885.42244754089, 8773.859398278215, 8793.296536277083, 8827.867581986275, 8837.116288371144, 8856.0, 8678.218960293603, 8790.912090879074, 8794.076621954666, 8817.955910220471, 8821.911780882238, 40352.39471407931, 40403.0, 40719.38920916188, 40775.7961210195, 40835.0, 3551.804650744208, 3773.603771603997, 3786.318462676717, 4144.772037537934, 4248.893777655583, 32061.51907721386, 32223.838880805444, 32396.0, 32923.17692057694, 32947.3410531788, 4268.2743933531065, 4309.849155279581, 4359.17175736609, 4413.117376524676, 4483.708558943658, 353176.0, 353698.0, 353797.0, 354652.0, 356096.0, 59446.13600116065, 59496.702516488, 60126.09810852841, 60224.69887650534, 60480.69759651262, 35591.0, 61695.38304616986, 62266.0, 62622.68688656527, 62623.0, 15936.601584960468, 16405.83594164043, 16436.506904792874, 16443.917780411022, 16493.515583597295, 11924.701882453008, 11948.880511194951, 11984.40077996114, 12010.339431331186, 12072.215306005082, 19683.212671493267, 19786.01069946497, 19867.900660496605, 19912.800871991094, 19976.20095196176, 7110.822229444305, 7246.202917679051, 7484.706729039205, 7610.429217808686, 7708.961455192688, 958.6596758150756, 973.5862258540234, 976.7021058577202, 1057.2493529593921, 1145.9140564457698, 32663.51477511572, 32872.50691239633, 33108.503372449435, 33237.50143747846, 33295.334093318, 1108.6064447121155, 1125.6735546691532, 1215.6960759810047, 1215.969600759988, 1237.8947789437818, 17299.962002279903, 17557.561060973323, 17623.0, 17696.557586060193, 17765.555861103578, 605282.0, 607789.0, 612141.0, 612283.0, 612530.0, 59485.107723384186, 59651.40348596458, 59669.403305966385, 59790.70104649449, 60047.39952600418, 1297.3059413213884, 1362.2303398579968, 1373.4986729843736, 1385.6951470676436, 1389.833220013605, 30555.2361190972, 31934.52098218575, 32159.51760723544, 32341.514877277332, 32782.18044548905, 52605.21092183544, 52652.21021684755, 52772.472275276756, 52889.20666190087, 53187.46812531825, 406539.0, 413459.0, 416182.0, 417746.0, 418281.0, 28179.0, 28209.294767630974, 28385.29036774097, 28513.28716782097, 28539.143825685263, 48427.660422478795, 49153.0, 49199.0, 49615.50384496109, 50528.74735626298, 40416.3937540943, 41801.372979404725, 42849.571504284555, 43102.78448607737, 43473.34789978216, 41786.37320440257, 42174.78912605417, 42427.0, 42550.14899701927, 42836.357454638826, 41170.58829411787, 44514.3322850151, 44829.55170448254, 45525.31712024256, 45747.0, 36310.8184459076, 38341.079657342794, 38592.80703596464, 38901.416478752275, 38903.80548097241, 28745.425091497633, 28942.42115157643, 28950.855245723636, 29140.0, 29182.416351673273], "value": 20417.405485975298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.5893473450773, 389.55201518254023, 392.3859160413952, 398.66312965544114, 413.02320013168844, 17881.64236715265, 19178.904105479487, 19457.832530048207, 19577.0, 19964.201431942703, 18958.526036849053, 19249.422517324503, 19591.902040489815, 19629.90185049073, 19642.410727678194, 5424.864378390552, 5640.605157638967, 5653.604247702652, 5710.257666503348, 5863.472287494124, 5554.50009499145, 5635.267415236013, 5640.971795141039, 5684.8294551163535, 5967.462928336449, 5898.203742494751, 5904.261967254093, 5912.142739302799, 5928.081147422156, 5954.523638108963, 5621.072523033695, 5811.82564523065, 5855.970720146414, 5883.382244864292, 5889.087191485327, 5635.295588051494, 5676.489115979582, 5697.4587414195585, 5718.485336319751, 5722.599418040739, 13671.0, 19982.70025949612, 22762.20332288362, 22849.885750571142, 22940.08239670411, 2206.6910632511463, 2211.2474427497887, 2236.4520692430297, 2251.0, 2316.2587971849016, 9505.857412138823, 9600.423974561549, 9772.471097545142, 9942.652007179713, 9995.550200241007, 1934.7484826972545, 1956.149075152299, 1978.0, 1994.4714650617598, 2043.9080241389174, 61057.64182969935, 68746.65626671835, 70615.2938470619, 79271.20728792754, 81801.0, 10109.64616238428, 10392.844107338396, 10749.731256718645, 10866.836997445045, 10921.508532115915, 15032.248387580577, 15109.697806044038, 15113.848861511464, 15160.924195378953, 15207.391704331923, 7804.648790804314, 8160.102388737234, 8163.7142700005215, 8321.417500774887, 8417.0, 7891.368690504861, 8020.077691065486, 8063.153368896299, 8105.189481051848, 8165.265126138676, 4603.746793926299, 4672.789724462407, 4682.906341873144, 4741.928871066937, 4776.641751868624, 1966.2135145941738, 2000.5598768271248, 2024.5647185855112, 2046.2531176120906, 2085.7705652378227, 933.3326671429825, 990.3612170150212, 1010.545254635417, 1043.9164866810636, 1063.7553362726617, 18293.268269269345, 19034.428967131007, 19253.0, 19612.21551137967, 19791.703124453146, 996.8006398720285, 999.9400035997863, 1018.2617602238466, 1047.8847326794046, 1059.782744537368, 10321.483925803679, 10888.455577221266, 10946.0, 10961.561537538568, 10967.83548246777, 486153.0, 501247.0, 504999.0, 506034.0, 508468.0, 76607.0, 98065.50967245118, 98416.0, 101462.0, 101625.0, 1019.50553981319, 1035.7514196592915, 1036.1451802263164, 1041.234692501011, 1044.3994703045628, 17675.558111047325, 17910.283588656308, 18095.819041809413, 18102.45692629223, 18297.45107646773, 28455.146345609664, 29186.7081329184, 32604.0, 42739.57260427481, 43745.125097497235, 60076.69961650164, 60505.69747151236, 60966.390336097844, 61811.38188618056, 62683.37316626775, 8071.273585377344, 8479.745607631781, 8563.57182140878, 8752.081031491856, 8815.559222039, 11885.940570297093, 12966.546170883974, 12969.286689232184, 13308.201507909556, 13415.865841341853, 11197.384143872165, 11343.886561134283, 11520.423978801195, 11561.537538498702, 11652.766944661229, 10941.179411544324, 11569.0, 11630.883691163319, 11682.94158529202, 11787.233829801036, 11675.88324116782, 11770.470328835052, 11828.70428239301, 11844.0, 11882.346470944181, 7284.526505777108, 7673.923260767321, 7737.0, 7954.403419743427, 8810.559472026245, 11206.551737930718, 11516.712082198012, 11559.826602601135, 11565.710857228636, 11771.11716621274], "value": 9137.829090471856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.682336709291, 1538.63072862513, 1695.788026496688, 1789.910504474776, 1849.306510058728, 8025.23760242776, 8446.873296900552, 8696.1303869613, 9285.0, 9296.628134874605, 8447.366447516446, 8656.0, 8678.826423471543, 8704.173103555167, 8786.6924657637, 2328.138588722171, 2364.43253619131, 2365.6924599802, 2370.1941339944415, 2380.059876348841, 2333.195047708538, 2367.9644805327935, 2408.0608562660577, 2429.4898071404937, 2433.610622300432, 2349.718033835942, 2354.9646755298686, 2358.2335740884196, 2371.229350461107, 2379.393254720044, 2273.4771002669477, 2275.1695631094613, 2280.4184932842186, 2282.82878784091, 2315.988420057889, 2208.5251670890834, 2217.7782221777693, 2227.576760415532, 2228.5097278598682, 2232.9888350558304, 8709.477431354077, 8720.694775682821, 8764.992025917038, 8766.474011559263, 8823.955880220621, 5123.052235336475, 5184.533391994739, 5211.635185537014, 5216.739163041832, 5219.556337711299, 3379.3917094922904, 3443.5523381960434, 3562.893113206582, 3591.102224443889, 3598.442241452579, 1130.8336657359362, 1183.1422218891234, 1187.1215300677522, 1191.994040029803, 1203.9759204815941, 12188.756224875542, 12349.753004939941, 12444.502219911192, 12456.81314780279, 12535.56125535611, 4647.488776234612, 4675.953240467552, 4765.880852978703, 4766.404199475066, 4766.928496072562, 10558.894411055944, 10576.206784491194, 10588.523516441779, 10593.629222977159, 10629.627963021412, 5369.812056578001, 5376.973115134478, 5416.052190866582, 5425.403205647375, 5426.403095659474, 4414.84548040817, 4800.615950723934, 4848.757562121879, 4974.602031837517, 4975.427825800007, 3860.864869729602, 3959.6832253419657, 3995.5405128410025, 4036.8587099451966, 4150.79246037703, 1274.496094608371, 1289.207137610363, 1301.947922083106, 1310.377570653951, 1321.9933900330436, 865.2256230673512, 1018.8369860822232, 1033.266380869576, 1037.1391744851755, 1038.9869876870143, 6064.4238797315065, 6235.594686345373, 6235.625862448268, 6263.906041409383, 6330.746770129143, 443.26860679878456, 443.7027191781514, 452.72383845854, 453.62122627606317, 458.43841294414744, 4272.786360682016, 4341.82632694695, 4357.978210108992, 4362.890927726832, 4379.868603941887, 10816.242862999672, 11159.776804463865, 11160.888391115985, 11237.943810280896, 11250.606228782117, 10290.0, 11072.446377681084, 11150.49822757978, 11162.162837787198, 11193.608223712132, 8055.879161812578, 8393.6222869971, 8411.116832732598, 8438.240558349655, 8468.745937621881, 6011.398860113954, 6210.161628180138, 6245.7189426476825, 6267.843303917256, 6312.183821563894, 9823.705288841345, 9972.551235194289, 9997.800043999225, 10070.093691567794, 10117.544710488193, 10083.294169408071, 10093.0, 10093.243006774668, 10152.898471015194, 10208.081272685495, 7886.132525422085, 7915.327197188073, 7999.120096789465, 8036.116027237116, 8057.0734365548715, 8470.449420787629, 8518.105598912025, 8555.101714320155, 8562.914370856211, 8576.185262400062, 7634.847303054019, 7856.5678887661725, 7912.32745216663, 8069.193080691884, 8070.757877263692, 7517.586532740752, 7546.811329716801, 7743.7676869694, 7744.225577442211, 7867.567283799217, 6712.496562757715, 6740.932590674227, 6805.115335006615, 6837.384635382839, 6851.657417129223, 5171.0, 5269.762860671202, 5273.973630131824, 5327.0, 5389.730513474232, 5064.392272927273, 5238.947610523998, 5376.946230537645, 5465.863353416037, 5482.17767334903], "value": 4619.428557779613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2354311424139, 326.2187061986542, 327.98524066417014, 332.2292281905979, 334.4064285892539, 5402.78388864445, 5561.0, 5563.944360556398, 5660.858478538039, 5668.801591944288, 5528.530074943625, 5564.916526252109, 5599.440055994399, 5605.523530499912, 5639.802606908759, 4308.80610372534, 4334.45819272591, 4337.978310108445, 4339.804708788112, 4343.132453045189, 4105.568915263899, 4311.361682560622, 4319.179355922381, 4329.696921215516, 4337.956620433787, 4276.828926842923, 4278.657707383401, 4282.250606143913, 4307.633851122659, 4333.60997510224, 4286.7139858042465, 4304.677149213806, 4304.870853874389, 4321.135772845412, 4325.437693099877, 3565.23347480293, 3767.6797472214894, 3772.320982223199, 3786.2995345860827, 3801.448789925473, 5283.365996080456, 5315.3423288355825, 5347.358317001985, 5352.625316227865, 5381.165919282517, 4878.414590249157, 4879.707217566922, 4891.51084891508, 4906.337644418029, 4911.901761964741, 5642.7178641067785, 5772.769089236425, 5800.651960882361, 5802.883942321172, 5845.941540584582, 4077.184563087365, 4091.6931230157857, 4097.160082183145, 4101.91796164078, 4127.711060225785, 5953.970230148865, 6012.969935150296, 6037.860312637448, 6045.244344456943, 6099.48154406876, 3974.2250261198787, 4166.416701661769, 4191.580841915784, 4203.43253660758, 4229.519668116135, 4279.807408666617, 4282.571742825755, 4294.720843145185, 4304.78476076195, 4312.7627980461375, 4934.6545741798445, 4941.555260026543, 4943.283223932582, 4945.010997800454, 4966.90066198674, 5724.370319264877, 5884.58807883444, 5967.776605795888, 5986.5210783137245, 5988.131720900445, 1455.3596417576232, 1473.963150921214, 1474.2555009720238, 1477.682298305848, 1484.5546336099128, 924.1545751537826, 933.4446004627235, 938.057252461272, 954.9713508594754, 956.4404823178519, 5176.240078373371, 5190.948090519122, 5200.777817212952, 5201.699575106223, 5224.50367215114, 5485.807996720096, 5508.55931525477, 5515.531179849758, 5518.19986102021, 5541.725403157297, 4949.282354058641, 5092.898142037213, 5117.0, 5121.8463446096675, 5136.0, 2838.545832666805, 2870.7129287071543, 2895.319599894023, 2902.2889392099073, 2903.50640391134, 5532.585056120726, 5563.13771365439, 5575.247341608912, 5607.943920560824, 5656.349519805192, 5138.845834624967, 5375.3549574050585, 5430.456954304538, 5499.615026948155, 5519.405879236752, 5500.762328476061, 5576.7211639417865, 5600.831975040755, 5628.917300598723, 5672.914906276409, 5082.796688132434, 5222.791088356423, 5436.184572314184, 5456.972715136399, 5486.369067557122, 5268.552173065333, 5272.78908843642, 5335.719427337489, 5345.33183352081, 5346.732663366738, 5517.0, 5608.298962629671, 5632.577556683347, 5656.717164141859, 5996.580239383201, 3998.0804414984136, 4149.27387707144, 4151.584841515824, 4158.750474971512, 4164.12553363797, 5963.589141672633, 5965.433283838029, 6021.698915054318, 6028.819135425944, 6080.2399700037495, 5756.30924289088, 5886.735096920564, 5889.175515427758, 5911.852203694942, 5923.585349025527, 5836.299644042742, 5885.61743486672, 5937.139114828412, 5941.1385349125, 5948.524118070457, 5539.944600553943, 5632.7183640816975, 5687.289088863892, 5729.8567535811935, 5769.22115514417, 5585.525230355465, 5806.200077975841, 5815.41845815415, 5863.794767183128, 5885.176075349369, 5716.742746576331, 5738.3071993761105, 5758.3090029196765, 5795.594308398372, 5803.607134287825], "value": 4303.7686683200145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3236720767707, 784.5057613703366, 789.8894154818327, 810.157436266283, 837.401258100458, 15309.693806123885, 16502.174891255418, 16595.253213605385, 16670.416535421264, 16741.079240641775, 15007.774883376731, 15350.232488375592, 15426.69146617067, 15429.768553471707, 15483.0, 679.4700133895569, 801.3268854162502, 815.3762371785574, 836.113719457374, 837.3301358912876, 817.8732296494023, 824.9546274954876, 825.1707034430389, 825.6160885188386, 827.7061643116697, 854.3336197765752, 858.5063588436643, 860.9612567434481, 865.809521905183, 865.9783505412352, 854.799122206281, 856.7900864288258, 858.7295002074358, 862.1593945902757, 866.2030931542996, 623.5385814497239, 624.5846512069469, 624.9062640603901, 625.5808608232495, 625.7559551774812, 15240.847591524054, 15279.388824447009, 15322.463713769965, 15334.769978450333, 15353.232338383148, 15207.543773686808, 15833.445829395916, 15943.0, 16093.517194484184, 16421.507354779376, 12561.434735436927, 12619.621411357673, 12842.678933026657, 12901.548445804445, 13184.868151318557, 3999.900002499932, 4013.919721605581, 4065.532463766675, 4177.12280421112, 4189.581041895816, 79107.60446197732, 79493.20506794917, 81613.0, 81667.5916620419, 81689.0, 12071.577494787816, 12391.566295179626, 12392.256464612152, 12452.75094498105, 12511.56209532662, 23427.06291748311, 23467.0, 23535.17626883051, 23650.4087397813, 23673.28980130599, 8885.955570222108, 8915.509646969478, 9072.591733372014, 9226.769330766785, 9311.06889311077, 4530.977345113253, 4795.95204047962, 4845.0, 4905.411350637946, 5007.824726134568, 3707.666310032056, 3820.2550502651716, 3844.59631738669, 3848.749831260959, 3856.82644281008, 604.4861867412664, 610.9663968481688, 613.0620151168719, 621.5369549685423, 622.7944778223175, 774.7714424244862, 780.6877249100291, 782.5383024015745, 797.2824457987857, 817.2032268538246, 10509.106725928381, 10527.473626318653, 10587.417692027013, 10705.46472676363, 10710.625128120479, 782.4288269563251, 786.4809225910872, 792.1167897793919, 799.8400319936036, 811.8051667599851, 4935.432425271068, 4997.375328083989, 5014.548690617862, 5029.371328583927, 5050.671706339076, 80029.0, 117689.76171667902, 119969.40015299867, 125504.0, 126550.0, 68674.3132568668, 81661.59169204115, 84091.0, 104836.0, 105470.0, 85106.57446712727, 87311.56344218238, 87541.56229218813, 87747.0, 88540.11459885447, 9933.403995760278, 10102.444365559964, 10332.638357657446, 10639.202059845697, 10700.143988480748, 47470.0, 50248.0, 51304.743476283875, 51607.225891612405, 52030.0, 64832.6758366224, 65988.34011659822, 72003.63998179976, 73426.63286683532, 74186.0, 12926.224426534438, 13005.804912926504, 13106.672333191747, 13329.533466328632, 13783.173009619455, 15096.54710358647, 15269.160196189316, 15363.692726145639, 15468.381264749283, 15523.534293971199, 14154.43382264739, 14195.716085678436, 14331.641708957359, 14511.274436277932, 14721.190334531275, 14253.358598863284, 14322.427102915766, 14493.202873841617, 14568.708625827212, 14629.92685036568, 13533.458661653423, 13586.592402227949, 13798.862011379757, 13847.723045539235, 14020.719585608027, 11602.47788849487, 11672.824907626222, 11746.29522228669, 11882.584109556125, 12257.448414821532, 11665.183437159318, 11815.527378904748, 11877.584284550345, 11953.581624643095, 12087.576934807239], "value": 7851.319823403296, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 113.0, 109.0, 110.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 163.0, 191.0, 127.0, 163.0, 159.0, 127.0, 192.0, 128.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 162.0, 162.0, 164.0, 172.0, 164.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 159.0, 75.0, 75.0, 74.0, 77.0, 167.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 145.0, 85.0, 85.0, 86.0, 141.0, 85.0, 85.0, 146.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 148.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 98.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 53.0, 55.0, 52.0, 54.0, 53.0, 52.0, 51.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 80.0, 80.0, 81.0, 81.0, 82.0, 80.0, 110.0, 80.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 122.0, 135.0, 133.0, 124.0, 133.0, 127.0, 126.0, 138.0, 136.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 163.0, 163.0, 164.0, 158.0, 164.0, 160.0, 158.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 62.0, 64.0, 67.0, 62.0, 63.0, 65.0, 62.0], "value": 63.7, "unit": "score"}]}]} 06:09:53 INFO - Return code: 0 06:09:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:54 ERROR - # TBPL SUCCESS # 06:09:54 INFO - Running post-action listener: _resource_record_post_action 06:09:54 INFO - ##### 06:09:54 INFO - ##### Finished run-tests step (success) 06:09:54 INFO - ##### 06:09:54 INFO - Running post-run listener: _resource_record_post_run 06:09:54 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 551137280; Read time: 0; Write time: 441864 06:09:54 INFO - TinderboxPrint: CPU usage
13.6% 06:09:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:09:54 INFO - TinderboxPrint: I/O write bytes / time
551,137,280 / 441,864 06:09:54 INFO - TinderboxPrint: CPU idle
8,206.9 (86.4%) 06:09:54 INFO - TinderboxPrint: CPU user
1,233.2 (13.0%) 06:09:54 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257024000; Read time: 0; Write time: 211228 06:09:54 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 0; Write bytes: 293527552; Read time: 0; Write time: 230628 06:09:54 INFO - Running post-run listener: _upload_blobber_files 06:09:54 INFO - Blob upload gear active. 06:09:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:54 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 06:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:56 INFO - (blobuploader) - INFO - Done attempting. 06:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:59 INFO - (blobuploader) - INFO - Done attempting. 06:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:00 INFO - (blobuploader) - INFO - Done attempting. 06:10:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:00 INFO - Return code: 0 06:10:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881d02663bc0987053bbdf4412dad65a3f71769a3ba8fb570ec7274bda143cf765ae74cd89290898148826911b96feb072c3eddce9a3ac0415ff83b673b15e57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae56e27d8a990d686284773c7138305a0c0ddc244dffbf86ea026ff083a3be7e2d91b125ad13278ac4362031069e711e3879b600262c958de0b40747a8c9ecc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd671d9393d15c1df85978cb1c30b74f284af713ceaa310de076ea315230fa007d4c18d1292f534e649ad76ac11d8b1d5c5e50d681b8f1b1512a4fa34cdb907"} 06:10:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:00 INFO - Contents: 06:10:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881d02663bc0987053bbdf4412dad65a3f71769a3ba8fb570ec7274bda143cf765ae74cd89290898148826911b96feb072c3eddce9a3ac0415ff83b673b15e57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae56e27d8a990d686284773c7138305a0c0ddc244dffbf86ea026ff083a3be7e2d91b125ad13278ac4362031069e711e3879b600262c958de0b40747a8c9ecc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd671d9393d15c1df85978cb1c30b74f284af713ceaa310de076ea315230fa007d4c18d1292f534e649ad76ac11d8b1d5c5e50d681b8f1b1512a4fa34cdb907"} 06:10:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:00 INFO - Copying logs to upload dir... 06:10:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.766349 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-03 06:10:00.147533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 06:10:00.151493) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881d02663bc0987053bbdf4412dad65a3f71769a3ba8fb570ec7274bda143cf765ae74cd89290898148826911b96feb072c3eddce9a3ac0415ff83b673b15e57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae56e27d8a990d686284773c7138305a0c0ddc244dffbf86ea026ff083a3be7e2d91b125ad13278ac4362031069e711e3879b600262c958de0b40747a8c9ecc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd671d9393d15c1df85978cb1c30b74f284af713ceaa310de076ea315230fa007d4c18d1292f534e649ad76ac11d8b1d5c5e50d681b8f1b1512a4fa34cdb907"} build_url:https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/VGxx3uBvSju4QK-uE951HQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881d02663bc0987053bbdf4412dad65a3f71769a3ba8fb570ec7274bda143cf765ae74cd89290898148826911b96feb072c3eddce9a3ac0415ff83b673b15e57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae56e27d8a990d686284773c7138305a0c0ddc244dffbf86ea026ff083a3be7e2d91b125ad13278ac4362031069e711e3879b600262c958de0b40747a8c9ecc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd671d9393d15c1df85978cb1c30b74f284af713ceaa310de076ea315230fa007d4c18d1292f534e649ad76ac11d8b1d5c5e50d681b8f1b1512a4fa34cdb907"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 06:10:00.178496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:10:00.178915) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464958000.260948-1284182905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:10:00.264991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 06:10:00.265383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 06:10:00.265820) ========= ========= Total master_lag: 0.44 =========