builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1465043957.92 results: success (0) buildid: 20160604030215 builduid: b83c92e7fe1a45eaae1ec3314ea25653 revision: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:17.925030) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:17.925683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:17.925968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:17.989970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:17.990239) ========= 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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 05:39:18-- 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% 70.3M=0s 2016-06-04 05:39:18 (70.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.157873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.158200) ========= 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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014188 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.208703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.209061) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 --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 f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 --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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 05:39:18,807 truncating revision to first 12 chars 2016-06-04 05:39:18,807 Setting DEBUG logging. 2016-06-04 05:39:18,807 attempt 1/10 2016-06-04 05:39:18,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f3740cfc4b04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 05:39:19,133 unpacking tar archive at: mozilla-central-f3740cfc4b04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.900074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.900389) ========= script_repo_revision: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.900830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.901158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 05:39:18.911647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-04 05:39:18.912105) ========= /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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:19 INFO - MultiFileLogger online at 20160604 05:39:19 in /builds/slave/test 05:39:19 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:39:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:19 INFO - {'append_to_log': False, 05:39:19 INFO - 'base_work_dir': '/builds/slave/test', 05:39:19 INFO - 'blob_upload_branch': 'Firefox', 05:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:19 INFO - 'branch': 'Firefox', 05:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:19 INFO - 'config_files': ('talos/linux_config.py',), 05:39:19 INFO - 'default_actions': ('clobber', 05:39:19 INFO - 'read-buildbot-config', 05:39:19 INFO - 'download-and-extract', 05:39:19 INFO - 'populate-webroot', 05:39:19 INFO - 'create-virtualenv', 05:39:19 INFO - 'install', 05:39:19 INFO - 'run-tests'), 05:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:19 INFO - 'download_minidump_stackwalk': True, 05:39:19 INFO - 'download_symbols': 'ondemand', 05:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:19 INFO - 'installer_path': 'installer.exe', 05:39:19 INFO - 'log_level': 'info', 05:39:19 INFO - 'log_name': 'talos', 05:39:19 INFO - 'log_to_console': True, 05:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:19 INFO - 'opt_config_files': (), 05:39:19 INFO - 'pip_index': False, 05:39:19 INFO - 'sps_profile': False, 05:39:19 INFO - 'sps_profile_interval': 0, 05:39:19 INFO - 'suite': 'dromaeojs-e10s', 05:39:19 INFO - 'system_bits': '32', 05:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:19 INFO - 'title': 'talos-linux64-ix-021', 05:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:19 INFO - 'use_talos_json': True, 05:39:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:19 INFO - 'work_dir': 'build'} 05:39:19 INFO - ##### 05:39:19 INFO - ##### Running clobber step. 05:39:19 INFO - ##### 05:39:19 INFO - Running pre-action listener: _resource_record_pre_action 05:39:19 INFO - Running main action method: clobber 05:39:19 INFO - rmtree: /builds/slave/test/build 05:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:20 INFO - Running post-action listener: _resource_record_post_action 05:39:20 INFO - ##### 05:39:20 INFO - ##### Finished clobber step (success) 05:39:20 INFO - ##### 05:39:20 INFO - ##### 05:39:20 INFO - ##### Running read-buildbot-config step. 05:39:20 INFO - ##### 05:39:20 INFO - Running pre-action listener: _resource_record_pre_action 05:39:20 INFO - Running main action method: read_buildbot_config 05:39:20 INFO - Using buildbot properties: 05:39:20 INFO - { 05:39:20 INFO - "project": "", 05:39:20 INFO - "product": "firefox", 05:39:20 INFO - "script_repo_revision": "production", 05:39:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:20 INFO - "repository": "", 05:39:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:20 INFO - "buildid": "20160604030215", 05:39:20 INFO - "stage_platform": "linux64-pgo", 05:39:20 INFO - "basedir": "/builds/slave/test", 05:39:20 INFO - "nightly_build": "True", 05:39:20 INFO - "buildnumber": 236, 05:39:20 INFO - "slavename": "talos-linux64-ix-021", 05:39:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:20 INFO - "platform": "ubuntu64_hw", 05:39:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:20 INFO - "branch": "mozilla-central", 05:39:20 INFO - "repo_path": "mozilla-central", 05:39:20 INFO - "revision": "f3740cfc4b04fb61a1da306df4b1c2437f6bfb65", 05:39:20 INFO - "pgo_build": "True", 05:39:20 INFO - "builduid": "b83c92e7fe1a45eaae1ec3314ea25653", 05:39:20 INFO - "slavebuilddir": "test" 05:39:20 INFO - } 05:39:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:39:20 INFO - Running post-action listener: _resource_record_post_action 05:39:20 INFO - ##### 05:39:20 INFO - ##### Finished read-buildbot-config step (success) 05:39:20 INFO - ##### 05:39:20 INFO - ##### 05:39:20 INFO - ##### Running download-and-extract step. 05:39:20 INFO - ##### 05:39:20 INFO - Running pre-action listener: _resource_record_pre_action 05:39:20 INFO - Running main action method: download_and_extract 05:39:20 INFO - mkdir: /builds/slave/test/build/tests 05:39: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:39:20 INFO - https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:25 INFO - Downloaded 1361 bytes. 05:39:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:25 INFO - Using the following test package requirements: 05:39:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'jsshell-linux-x86_64.zip'], 05:39:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:25 INFO - https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:29 INFO - Downloaded 24440659 bytes. 05:39: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:39: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:39:30 INFO - Return code: 0 05:39: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:39: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:39:30 INFO - https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:38 INFO - Downloaded 24440659 bytes. 05:39:38 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:39:38 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:39:39 INFO - Return code: 0 05:39:39 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:39:39 INFO - https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:40 INFO - Downloaded 10833369 bytes. 05:39:40 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:39:40 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:39:41 INFO - Return code: 0 05:39: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:39:41 INFO - https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3ok02QrSp6yp7VIfOmHRA/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:39:42 INFO - Downloaded 59145020 bytes. 05:39:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:42 INFO - mkdir: /builds/slave/test/properties 05:39:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:42 INFO - Contents: 05:39:42 INFO - build_url:https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:43 INFO - Running post-action listener: _resource_record_post_action 05:39:43 INFO - Running post-action listener: set_extra_try_arguments 05:39:43 INFO - ##### 05:39:43 INFO - ##### Finished download-and-extract step (success) 05:39:43 INFO - ##### 05:39:43 INFO - ##### 05:39:43 INFO - ##### Running populate-webroot step. 05:39:43 INFO - ##### 05:39:43 INFO - Running pre-action listener: _resource_record_pre_action 05:39:43 INFO - Running main action method: populate_webroot 05:39:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:43 INFO - '--tppagecycles', 05:39:43 INFO - '7'], 05:39:43 INFO - 'tests': ['tsvgm']}}, 05:39:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['damp', 'tps']}, 05:39:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'tests': ['damp', 'tps']}, 05:39:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['dromaeo_dom']}, 05:39:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['a11yr', 05:39:43 INFO - 'ts_paint', 05:39:43 INFO - 'tpaint', 05:39:43 INFO - 'sessionrestore', 05:39:43 INFO - 'sessionrestore_no_auto_restore', 05:39:43 INFO - 'tabpaint']}, 05:39:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['tsvgx', 05:39:43 INFO - 'tsvgr_opacity', 05:39:43 INFO - 'tart', 05:39:43 INFO - 'tscrollx', 05:39:43 INFO - 'cart']}, 05:39:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:43 INFO - 'tsvgr_opacity', 05:39:43 INFO - 'tart', 05:39:43 INFO - 'tscrollx', 05:39:43 INFO - 'cart']}, 05:39:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'talos_options': ['--disable-e10s'], 05:39:43 INFO - 'tests': ['tp5o']}, 05:39:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'tests': ['tp5o']}, 05:39:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'talos_options': ['--disable-e10s', 05:39:43 INFO - '--xperf_path', 05:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:43 INFO - 'tests': ['tp5n']}, 05:39:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:43 INFO - 'talos_options': ['--xperf_path', 05:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:43 INFO - 'tests': ['tp5n']}}, 05:39:43 INFO - 'talos.zip': {'path': '', 05:39:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:43 INFO - Running post-action listener: _resource_record_post_action 05:39:43 INFO - ##### 05:39:43 INFO - ##### Finished populate-webroot step (success) 05:39:43 INFO - ##### 05:39:43 INFO - ##### 05:39:43 INFO - ##### Running create-virtualenv step. 05:39:43 INFO - ##### 05:39:43 INFO - Running pre-action listener: _resource_record_pre_action 05:39:43 INFO - Running main action method: create_virtualenv 05:39:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:43 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:39:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:43 INFO - Using real prefix '/usr' 05:39:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:46 INFO - Installing pip.................done. 05:39:46 INFO - Return code: 0 05:39:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:46 INFO - Using env: {'DISPLAY': ':0', 05:39:46 INFO - 'HOME': '/home/cltbld', 05:39:46 INFO - 'LANG': 'en_US.UTF-8', 05:39:46 INFO - 'LANGUAGE': 'en_US:en', 05:39:46 INFO - 'LOGNAME': 'cltbld', 05:39:46 INFO - 'MAIL': '/var/mail/cltbld', 05:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:46 INFO - 'MOZ_NO_REMOTE': '1', 05:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:46 INFO - 'NO_EM_RESTART': '1', 05:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:46 INFO - 'PWD': '/builds/slave/test', 05:39:46 INFO - 'SHELL': '/bin/bash', 05:39:46 INFO - 'SHLVL': '1', 05:39:46 INFO - 'TERM': 'linux', 05:39:46 INFO - 'TMOUT': '86400', 05:39:46 INFO - 'USER': 'cltbld', 05:39:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:46 INFO - '_': '/tools/buildbot/bin/python'} 05:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:46 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:39:46 INFO - Cleaning up... 05:39:46 INFO - Return code: 0 05:39:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:46 INFO - Using env: {'DISPLAY': ':0', 05:39:46 INFO - 'HOME': '/home/cltbld', 05:39:46 INFO - 'LANG': 'en_US.UTF-8', 05:39:46 INFO - 'LANGUAGE': 'en_US:en', 05:39:46 INFO - 'LOGNAME': 'cltbld', 05:39:46 INFO - 'MAIL': '/var/mail/cltbld', 05:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:46 INFO - 'MOZ_NO_REMOTE': '1', 05:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:46 INFO - 'NO_EM_RESTART': '1', 05:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:46 INFO - 'PWD': '/builds/slave/test', 05:39:46 INFO - 'SHELL': '/bin/bash', 05:39:46 INFO - 'SHLVL': '1', 05:39:46 INFO - 'TERM': 'linux', 05:39:46 INFO - 'TMOUT': '86400', 05:39:46 INFO - 'USER': 'cltbld', 05:39:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:46 INFO - '_': '/tools/buildbot/bin/python'} 05:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:46 INFO - Downloading/unpacking psutil>=3.1.1 05:39:46 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:39:46 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:39:46 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:39:46 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:39:46 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:39:46 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:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:48 INFO - Installing collected packages: psutil 05:39:48 INFO - Running setup.py install for psutil 05:39:48 INFO - building 'psutil._psutil_linux' extension 05:39:48 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:39:49 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:39:49 INFO - building 'psutil._psutil_posix' extension 05:39:49 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:39:49 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:39:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:49 INFO - Successfully installed psutil 05:39:49 INFO - Cleaning up... 05:39:49 INFO - Return code: 0 05:39:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39: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:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:39: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 mozsystemmonitor==0.3 05:39:49 INFO - Using env: {'DISPLAY': ':0', 05:39:49 INFO - 'HOME': '/home/cltbld', 05:39:49 INFO - 'LANG': 'en_US.UTF-8', 05:39:49 INFO - 'LANGUAGE': 'en_US:en', 05:39:49 INFO - 'LOGNAME': 'cltbld', 05:39:49 INFO - 'MAIL': '/var/mail/cltbld', 05:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:49 INFO - 'MOZ_NO_REMOTE': '1', 05:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:49 INFO - 'NO_EM_RESTART': '1', 05:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:49 INFO - 'PWD': '/builds/slave/test', 05:39:49 INFO - 'SHELL': '/bin/bash', 05:39:49 INFO - 'SHLVL': '1', 05:39:49 INFO - 'TERM': 'linux', 05:39:49 INFO - 'TMOUT': '86400', 05:39:49 INFO - 'USER': 'cltbld', 05:39:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:49 INFO - '_': '/tools/buildbot/bin/python'} 05:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39: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:39: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:39: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:39: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:39: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:39: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:39:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:51 INFO - Installing collected packages: mozsystemmonitor 05:39:51 INFO - Running setup.py install for mozsystemmonitor 05:39:51 INFO - Successfully installed mozsystemmonitor 05:39:51 INFO - Cleaning up... 05:39:51 INFO - Return code: 0 05:39:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:39: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:39: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:39: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:39: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:39: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:39: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:39:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:54 INFO - warning: no files found matching '*.txt' 05:39:54 INFO - no previously-included directories found matching 'build' 05:39:54 INFO - no previously-included directories found matching 'dist' 05:39:54 INFO - no previously-included directories found matching '.git*' 05:39:54 INFO - Installing collected packages: jsonschema, functools32 05:39:54 INFO - Running setup.py install for functools32 05:39:54 INFO - warning: no files found matching '*.txt' 05:39:54 INFO - no previously-included directories found matching 'build' 05:39:54 INFO - no previously-included directories found matching 'dist' 05:39:54 INFO - no previously-included directories found matching '.git*' 05:39:54 INFO - Successfully installed jsonschema functools32 05:39:54 INFO - Cleaning up... 05:39:54 INFO - Return code: 0 05:39:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:54 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:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39:54 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:39:54 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:39:54 INFO - Using env: {'DISPLAY': ':0', 05:39:54 INFO - 'HOME': '/home/cltbld', 05:39:54 INFO - 'LANG': 'en_US.UTF-8', 05:39:54 INFO - 'LANGUAGE': 'en_US:en', 05:39:54 INFO - 'LOGNAME': 'cltbld', 05:39:54 INFO - 'MAIL': '/var/mail/cltbld', 05:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:54 INFO - 'MOZ_NO_REMOTE': '1', 05:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:54 INFO - 'NO_EM_RESTART': '1', 05:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:54 INFO - 'PWD': '/builds/slave/test', 05:39:54 INFO - 'SHELL': '/bin/bash', 05:39:54 INFO - 'SHLVL': '1', 05:39:54 INFO - 'TERM': 'linux', 05:39:54 INFO - 'TMOUT': '86400', 05:39:54 INFO - 'USER': 'cltbld', 05:39:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:54 INFO - '_': '/tools/buildbot/bin/python'} 05:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - Downloading docopt-0.6.1.tar.gz 05:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:57 INFO - Running setup.py install for blobuploader 05:39:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:57 INFO - Running setup.py install for requests 05:39:57 INFO - Running setup.py install for docopt 05:39:57 INFO - Successfully installed blobuploader requests docopt 05:39:57 INFO - Cleaning up... 05:39:57 INFO - Return code: 0 05:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:57 INFO - Using env: {'DISPLAY': ':0', 05:39:57 INFO - 'HOME': '/home/cltbld', 05:39:57 INFO - 'LANG': 'en_US.UTF-8', 05:39:57 INFO - 'LANGUAGE': 'en_US:en', 05:39:57 INFO - 'LOGNAME': 'cltbld', 05:39:57 INFO - 'MAIL': '/var/mail/cltbld', 05:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:57 INFO - 'MOZ_NO_REMOTE': '1', 05:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:57 INFO - 'NO_EM_RESTART': '1', 05:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:57 INFO - 'PWD': '/builds/slave/test', 05:39:57 INFO - 'SHELL': '/bin/bash', 05:39:57 INFO - 'SHLVL': '1', 05:39:57 INFO - 'TERM': 'linux', 05:39:57 INFO - 'TMOUT': '86400', 05:39:57 INFO - 'USER': 'cltbld', 05:39:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:57 INFO - '_': '/tools/buildbot/bin/python'} 05:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:57 INFO - Running setup.py (path:/tmp/pip-ELAfsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:57 INFO - Running setup.py (path:/tmp/pip-N8em04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:58 INFO - Running setup.py (path:/tmp/pip-NQDN4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:58 INFO - Running setup.py (path:/tmp/pip-SY4mbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:58 INFO - Running setup.py (path:/tmp/pip-wWfPz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:58 INFO - Running setup.py (path:/tmp/pip-1WbXHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:58 INFO - Running setup.py (path:/tmp/pip-vpb2ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:58 INFO - Running setup.py (path:/tmp/pip-wHIGQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:58 INFO - Running setup.py (path:/tmp/pip-eHvMNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:58 INFO - Running setup.py (path:/tmp/pip-z4jF7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:58 INFO - Running setup.py (path:/tmp/pip-qz_4W8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:58 INFO - Running setup.py (path:/tmp/pip-UgoO7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:58 INFO - Running setup.py (path:/tmp/pip-1DljCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:58 INFO - Running setup.py (path:/tmp/pip-zjOPFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:58 INFO - Running setup.py (path:/tmp/pip-LG1vyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:58 INFO - Running setup.py (path:/tmp/pip-8cGgVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:59 INFO - Running setup.py (path:/tmp/pip-OT4DTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:59 INFO - Running setup.py install for manifestparser 05:39:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozcrash 05:39:59 INFO - Running setup.py install for mozdebug 05:39:59 INFO - Running setup.py install for mozdevice 05:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozfile 05:39:59 INFO - Running setup.py install for mozhttpd 05:39:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozinfo 05:39:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozInstall 05:39:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozleak 05:40:00 INFO - Running setup.py install for mozlog 05:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for moznetwork 05:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozprocess 05:40:00 INFO - Running setup.py install for mozprofile 05:40:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozrunner 05:40:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozscreenshot 05:40:00 INFO - Running setup.py install for moztest 05:40:00 INFO - Running setup.py install for mozversion 05:40:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:00 INFO - Cleaning up... 05:40:00 INFO - Return code: 0 05:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40: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:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:00 INFO - Using env: {'DISPLAY': ':0', 05:40:00 INFO - 'HOME': '/home/cltbld', 05:40:00 INFO - 'LANG': 'en_US.UTF-8', 05:40:00 INFO - 'LANGUAGE': 'en_US:en', 05:40:00 INFO - 'LOGNAME': 'cltbld', 05:40:00 INFO - 'MAIL': '/var/mail/cltbld', 05:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:00 INFO - 'MOZ_NO_REMOTE': '1', 05:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:00 INFO - 'NO_EM_RESTART': '1', 05:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:00 INFO - 'PWD': '/builds/slave/test', 05:40:00 INFO - 'SHELL': '/bin/bash', 05:40:00 INFO - 'SHLVL': '1', 05:40:00 INFO - 'TERM': 'linux', 05:40:00 INFO - 'TMOUT': '86400', 05:40:00 INFO - 'USER': 'cltbld', 05:40:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:00 INFO - '_': '/tools/buildbot/bin/python'} 05:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:01 INFO - Running setup.py (path:/tmp/pip-KRc3tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:01 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:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:01 INFO - Running setup.py (path:/tmp/pip-cq3QSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:01 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:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:01 INFO - Running setup.py (path:/tmp/pip-m9euNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:01 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:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:01 INFO - Running setup.py (path:/tmp/pip-_qE0rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:01 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:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:01 INFO - Running setup.py (path:/tmp/pip-4l0dJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:01 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:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:01 INFO - Running setup.py (path:/tmp/pip-p0nCAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:01 INFO - Running setup.py (path:/tmp/pip-yDYjDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:01 INFO - Running setup.py (path:/tmp/pip-4OV3Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:01 INFO - Running setup.py (path:/tmp/pip-chXejN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:01 INFO - Running setup.py (path:/tmp/pip-Qydj0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:01 INFO - Running setup.py (path:/tmp/pip-oUlUwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:01 INFO - Running setup.py (path:/tmp/pip-V07CKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:02 INFO - Running setup.py (path:/tmp/pip-iYK3L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:02 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:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:02 INFO - Running setup.py (path:/tmp/pip-xcQ6wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:02 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:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:02 INFO - Running setup.py (path:/tmp/pip-awi3rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:02 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:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:02 INFO - Running setup.py (path:/tmp/pip-Ac65No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:02 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:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:02 INFO - Running setup.py (path:/tmp/pip-h2vPmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:02 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:40:02 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:40:02 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:40:02 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:40:02 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:40:02 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:40:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40: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:40: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:40: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:40: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:40: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:40: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:40:04 INFO - Downloading blessings-1.6.tar.gz 05:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:04 INFO - Installing collected packages: blessings 05:40:04 INFO - Running setup.py install for blessings 05:40:04 INFO - Successfully installed blessings 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:04 INFO - Reading from file tmpfile_stdout 05:40:04 INFO - Current package versions: 05:40:04 INFO - argparse == 1.2.1 05:40:04 INFO - blessings == 1.6 05:40:04 INFO - blobuploader == 1.2.4 05:40:04 INFO - docopt == 0.6.1 05:40:04 INFO - functools32 == 3.2.3-2 05:40:04 INFO - jsonschema == 2.5.1 05:40:04 INFO - manifestparser == 1.1 05:40:04 INFO - mozInstall == 1.12 05:40:04 INFO - mozcrash == 0.17 05:40:04 INFO - mozdebug == 0.1 05:40:04 INFO - mozdevice == 0.48 05:40:04 INFO - mozfile == 1.2 05:40:04 INFO - mozhttpd == 0.7 05:40:04 INFO - mozinfo == 0.9 05:40:04 INFO - mozleak == 0.1 05:40:04 INFO - mozlog == 3.2 05:40:04 INFO - moznetwork == 0.27 05:40:04 INFO - mozprocess == 0.22 05:40:04 INFO - mozprofile == 0.28 05:40:04 INFO - mozrunner == 6.11 05:40:04 INFO - mozscreenshot == 0.1 05:40:04 INFO - mozsystemmonitor == 0.3 05:40:04 INFO - moztest == 0.7 05:40:04 INFO - mozversion == 1.4 05:40:04 INFO - psutil == 3.1.1 05:40:04 INFO - requests == 1.2.3 05:40:04 INFO - wsgiref == 0.1.2 05:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:04 INFO - Using env: {'DISPLAY': ':0', 05:40:04 INFO - 'HOME': '/home/cltbld', 05:40:04 INFO - 'LANG': 'en_US.UTF-8', 05:40:04 INFO - 'LANGUAGE': 'en_US:en', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MAIL': '/var/mail/cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SHLVL': '1', 05:40:04 INFO - 'TERM': 'linux', 05:40:04 INFO - 'TMOUT': '86400', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - '_': '/tools/buildbot/bin/python'} 05:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:04 INFO - Using env: {'DISPLAY': ':0', 05:40:04 INFO - 'HOME': '/home/cltbld', 05:40:04 INFO - 'LANG': 'en_US.UTF-8', 05:40:04 INFO - 'LANGUAGE': 'en_US:en', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MAIL': '/var/mail/cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SHLVL': '1', 05:40:04 INFO - 'TERM': 'linux', 05:40:04 INFO - 'TMOUT': '86400', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - '_': '/tools/buildbot/bin/python'} 05:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:05 INFO - Cleaning up... 05:40:05 INFO - Return code: 0 05:40:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:40:05 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:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:05 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:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:05 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 0x7f2d783d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, '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': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', '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:40:05 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:40:05 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:40:05 INFO - Using env: {'DISPLAY': ':0', 05:40:05 INFO - 'HOME': '/home/cltbld', 05:40:05 INFO - 'LANG': 'en_US.UTF-8', 05:40:05 INFO - 'LANGUAGE': 'en_US:en', 05:40:05 INFO - 'LOGNAME': 'cltbld', 05:40:05 INFO - 'MAIL': '/var/mail/cltbld', 05:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:05 INFO - 'MOZ_NO_REMOTE': '1', 05:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:05 INFO - 'NO_EM_RESTART': '1', 05:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:05 INFO - 'PWD': '/builds/slave/test', 05:40:05 INFO - 'SHELL': '/bin/bash', 05:40:05 INFO - 'SHLVL': '1', 05:40:05 INFO - 'TERM': 'linux', 05:40:05 INFO - 'TMOUT': '86400', 05:40:05 INFO - 'USER': 'cltbld', 05:40:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:05 INFO - '_': '/tools/buildbot/bin/python'} 05:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:05 INFO - Downloading/unpacking flake8 05:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:08 INFO - no previously-included directories found matching 'docs/_build' 05:40:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:08 INFO - Running setup.py install for pep8 05:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:08 INFO - no previously-included directories found matching 'docs/_build' 05:40:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:08 INFO - Cleaning up... 05:40:08 INFO - Return code: 0 05:40:08 INFO - Running post-action listener: _resource_record_post_action 05:40:08 INFO - Running post-action listener: _start_resource_monitoring 05:40:08 INFO - Starting resource monitoring. 05:40:08 INFO - ##### 05:40:08 INFO - ##### Finished create-virtualenv step (success) 05:40:08 INFO - ##### 05:40:08 INFO - ##### 05:40:08 INFO - ##### Running install step. 05:40:08 INFO - ##### 05:40:08 INFO - Running pre-action listener: _resource_record_pre_action 05:40:08 INFO - Running main action method: install 05:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:08 INFO - Reading from file tmpfile_stdout 05:40:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:08 INFO - Reading from file tmpfile_stdout 05:40:08 INFO - Output received: 05:40:08 INFO - Usage: mozinstall [options] installer 05:40:08 INFO - Options: 05:40:08 INFO - -h, --help show this help message and exit 05:40:08 INFO - -d DEST, --destination=DEST 05:40:08 INFO - Directory to install application into. [default: 05:40:08 INFO - "/builds/slave/test"] 05:40:08 INFO - --app=APP Application being installed. [default: firefox] 05:40:08 INFO - mkdir: /builds/slave/test/build/application 05:40:08 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:40:08 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:40:26 INFO - Reading from file tmpfile_stdout 05:40:26 INFO - Output received: 05:40:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:26 INFO - Running post-action listener: _resource_record_post_action 05:40:26 INFO - ##### 05:40:26 INFO - ##### Finished install step (success) 05:40:26 INFO - ##### 05:40:26 INFO - ##### 05:40:26 INFO - ##### Running run-tests step. 05:40:26 INFO - ##### 05:40:26 INFO - Running pre-action listener: _resource_record_pre_action 05:40:26 INFO - Running main action method: run_tests 05:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:26 INFO - Python 2.7.3 05:40:26 INFO - Return code: 0 05:40:26 INFO - grabbing minidump binary from tooltool 05:40: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:40:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d2990>, '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 0x263e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:40:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:40:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:40:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:26 INFO - Return code: 0 05:40:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:40:27 INFO - Return code: 0 05:40:27 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/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:40:27 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/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:40:27 INFO - Using env: {'DISPLAY': ':0', 05:40:27 INFO - 'HOME': '/home/cltbld', 05:40:27 INFO - 'LANG': 'en_US.UTF-8', 05:40:27 INFO - 'LANGUAGE': 'en_US:en', 05:40:27 INFO - 'LOGNAME': 'cltbld', 05:40:27 INFO - 'MAIL': '/var/mail/cltbld', 05:40:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:27 INFO - 'MOZ_NO_REMOTE': '1', 05:40:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:27 INFO - 'NO_EM_RESTART': '1', 05:40:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:27 INFO - 'PWD': '/builds/slave/test', 05:40:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:27 INFO - 'SHELL': '/bin/bash', 05:40:27 INFO - 'SHLVL': '1', 05:40:27 INFO - 'TERM': 'linux', 05:40:27 INFO - 'TMOUT': '86400', 05:40:27 INFO - 'USER': 'cltbld', 05:40:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465040080.48626-560449468', 05:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:27 INFO - '_': '/tools/buildbot/bin/python'} 05:40:27 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/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:40:27 INFO - mozversion application_buildid: 20160604030215 05:40:27 INFO - mozversion application_changeset: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 05:40:27 INFO - mozversion application_display_name: Nightly 05:40:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:27 INFO - mozversion application_name: Firefox 05:40:27 INFO - mozversion application_remotingname: firefox 05:40:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:27 INFO - mozversion application_vendor: Mozilla 05:40:27 INFO - mozversion application_version: 49.0a1 05:40:27 INFO - mozversion platform_buildid: 20160604030215 05:40:27 INFO - mozversion platform_changeset: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 05:40:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:27 INFO - mozversion platform_version: 49.0a1 05:40:27 INFO - using testdate: 1465044027 05:40:27 INFO - actual date: 1465044027 05:40:27 INFO - starting webserver on 'localhost:58885' 05:40:27 INFO - SUITE-START | Running 2 tests 05:40:27 INFO - TEST-START | dromaeo_css 05:40:27 INFO - operating with platform_type : linux_ 05:40:27 INFO - Initialising browser for dromaeo_css test... 05:40:27 INFO - TEST-INFO | started process 11345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rmtSw/profile http://localhost:58885/getInfo.html) 05:40:34 INFO - PROCESS | 11345 | __metrics Screen width/height:1600/1200 05:40:34 INFO - PROCESS | 11345 | colorDepth:24 05:40:34 INFO - PROCESS | 11345 | Browser inner width/height: 1024/697 05:40:34 INFO - PROCESS | 11345 | __metrics 05:40:35 ERROR - PROCESS | 11345 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:40:35 INFO - TEST-INFO | 11345: exit 0 05:40:35 INFO - Browser initialized. 05:40:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:35 INFO - TEST-INFO | started process 11465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rmtSw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:47 INFO - PROCESS | 11465 | RSS: Main: 167686144 05:40:47 INFO - PROCESS | 11465 | 05:41:37 INFO - PROCESS | 11465 | 1465044097304 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:43:44 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58885/tests/dromaeo/cssquery-ext.html) 05:43:45 INFO - PROCESS | 11465 | RSS: Main: 170582016 05:43:45 INFO - PROCESS | 11465 | 05:46:47 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-ext.html (next: http://localhost:58885/tests/dromaeo/cssquery-jquery.html) 05:46:48 INFO - PROCESS | 11465 | RSS: Main: 170295296 05:46:48 INFO - PROCESS | 11465 | 05:49:50 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58885/tests/dromaeo/cssquery-mootools.html) 05:49:50 INFO - PROCESS | 11465 | RSS: Main: 171573248 05:49:50 INFO - PROCESS | 11465 | 05:52:52 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58885/tests/dromaeo/cssquery-prototype.html) 05:52:53 INFO - PROCESS | 11465 | RSS: Main: 168493056 05:52:53 INFO - PROCESS | 11465 | 05:55:55 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58885/tests/dromaeo/cssquery-yui.html) 05:55:56 INFO - PROCESS | 11465 | RSS: Main: 170356736 05:55:56 INFO - PROCESS | 11465 | 05:58:58 INFO - PROCESS | 11465 | Cycle 1(1): loaded http://localhost:58885/tests/dromaeo/cssquery-yui.html (next: http://localhost:58885/tests/dromaeo/cssquery-dojo.html) 05:58:59 INFO - PROCESS | 11465 | RSS: Main: 171683840 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | __start_tp_report 05:58:59 INFO - PROCESS | 11465 | _x_x_mozilla_page_load 05:58:59 INFO - PROCESS | 11465 | _x_x_mozilla_page_load_details 05:58:59 INFO - PROCESS | 11465 | |i|pagename|runs| 05:58:59 INFO - PROCESS | 11465 | |0;dojo.html;3157.9526307105384;3169.1126484584315;3178.6344570374413;3180.363927214557;3198.584184056074;5387;5429.864253393667;5475.616706830523;5499.642523235987;5502.642328248671;5446.836594902149;5467.863303417416;5469.042917489433;5532.889342213153;5543.057680194366;5070.391553013644;5096.79612815487;5151.4075881273575;5174.586033117342;5241.161414173733;709.4682602696531;4994.300797888299;5072;5129.2562578426105;5159.432462429129;5106.66806657566;5112.335396398463;5143.871403214912;5152;5157.123289040854;5144.382674079135;5155.871103222412;5158.071547121516;5170.767315470813;5219.373675158968;4971.651984361096;5044.39467263927;5070.746462676888;5103.693778373309;5114;5510.090835012218;5529.364123125812;5530.059889818741;5531.419200983879;5573.832785016456;5833.06670932653;6030.879382412371;6037.879242415171;6045.063015232646;6058.787942421994;5874.177615133842;5881.500072493843;5915.526757859361;5957.374475680078;5963.13534537494;5519.199716041152;5552.805651802208;5565.916511252334;5572.749226284786;5580.748866300985;5823.912641310384;6040.365761595057;6093.329733729286;6097.115918191837;6106.145139680449;5865.120231965239;5865.560082993792;5914.142449344907;5945.346011938684;5973.1338955852025;6001.849953751103;6004.519638428916;6016.127661489059;6016.368281330398;6017.2779266488305;5751.252337196138;5876.3536011039605;5884.7940322088525;5921.73352199152;5993.820185394445;5919.585629005928;5977.641341519523;5980.700964951735;6000.639961602318;6043.033114701714;4479.260921947842;4493.168763778712;4495.955040449619;4503.797329120198;4554.476235232991;3903.746256493319;3987.900302492461;4002.8598999034893;4071.694622903294;4081.9387709184384;5503.559715222773;5555.972220138873;5575.637583557056;5594.468525490072;5676.2337084493065;5973.850653733692;6047.274327080779;6051.697415129314;6085.939140608537;6093.664848433379;5510.586705997066;5541.972290138604;5569.66582005081;5600.4959553640365;5693.829185124453;4896.632752543503;4898.387701537308;4900.485449027872;4902.705837649681;4916.041371932511;6088.695565221721;6088.756449742049;6113.205283313141;6113.20528331323;6118.1128736332985;5818.359980402152;5933.732982015733;5948.434898684618;5963.850903727268;5984.401559843981;6104.450599445893;6113.23584551931;6120.785772497941;6130.724117414817;6150.538709596709;5718.714064296852;5842.912356314574;5885.323187833454;5893.793717219876;5897.5576831736935;5898.3216930053595;5935.881282374242;5976.043832986701;5997.850053748692;6008.849778755566;5753.309602847685;5790.189373487631;5801.332846722512;5843.2695913010875;5859.677717725566;5681.9147712783515;5748.655080695172;5810.709464526842;5833.445822646841;5838.007538718513;5596.104623260258;5646.520045796154;5648.124540696034;5657.773689052392;5675.914861277001;5757.453041961007;5815.244018277766;5839.824805255849;5843.065109582616;5857.912131318119;5585.385607583244;5675.517581005661;5680.829575112753;5680.971595141998;5715.485606295453 05:58:59 INFO - PROCESS | 11465 | |1;ext.html;551.6634852739828;602.0607851751269;612.5038718637903;618.072890664004;647.207171215261;38676.226475470474;44368.33447498286;44423.111537769226;44442;44496.555034449644;44177.33733993985;45028;45101.54898451015;45179;45258;8725.825483490325;8783.73648790534;8837.55812209387;8885.600147993324;8901.109889011112;8774.868376974351;8796.956015219946;8874.245689116433;8874.689385871496;8874.911250887473;8900.910990890074;8909.955450222773;8928.419652722552;8934.329925255599;8943.50810705411;8859.689910853122;8868.8669669955;8938.374313798036;8942.910570894273;8948.507832069266;8851.513166775825;8943.016268210491;8943.910560894437;8944.821103577891;8949;40273.798631006954;40826.38760418596;40865.591344086475;41094.79452602748;41150.794246028876;3712.888613341577;3724.2179142380132;3757.699384049297;3821.847126114952;3878.4764056852528;32821.17947051319;33090.834545827114;33216;33513.3297334052;34028.31943361144;4294.049702311626;4371.781410929472;4383.561643835623;4405.140997505488;4498.100379924028;353655;354328;356266;356771;357128;34318.14204644904;34981.82509087438;60572.697136514034;61666.69166654138;61820;37117;37213.813930930715;37505.81247093747;37526.24947501034;37542.24915501675;14391.28043597837;14401.639959000899;14574.198419087052;14618.63453413652;14622.415103395744;12085.516579336903;12196.695082622828;12249.142560020713;12281.140320177501;12305.384730763426;8352;8387.62255698495;8471.745847624581;8520.8721869172;8537.487750734852;3235.5955505561806;3271.214908422009;3282.113829266085;3297.2745995881346;3333.4999750037687;1008.9192864570816;1035.5754140802235;1099.395332567085;1161.6456980620992;1227.2636418149038;31575;32112.83943580267;32125.51811722826;32461.35077298441;32640.347193056004;1124.966251012471;1167.371516734151;1181.9231749936228;1192.1416580062341;1258.4211262819022;16220.675586488203;16852.15739213059;17020.829791702174;17109;17310.394136205174;549765;555217;561471;562651;568513;57158.42841571531;58338;58405;58481.41518584845;58559;1333.1134795360977;1384.2870921475449;1391.7286129204708;1396.0925398490858;1399.9160050397008;30988.22529436782;31884;31920.201994950312;32082.19794505156;32393.51409728903;48980.75509622429;49998;50080.998380031466;50084;50155;484605;492735;493236;493476;493725;28443.43113137767;28819.855900720362;29047.709522905345;29100.854495727384;29177.7082229175;47810;48068.759656201495;48968.755156225416;49065.509344906095;49338.75330623324;40385.59614403819;41118.79440602778;41572.58427415687;42253.78873105615;42830.78584607182;39084;40987.59012409838;41540;41546;41858;36153;40752.59247407488;41585.792071039454;42562.361564575935;42741.35887961621;33768.66231337655;36474.8176259117;36860.26279474449;37361.25277494489;37470.43794343142;28601.570976435785;28729.56905646375;28849.711502884704;29010.274743130747;29119.563206551495 05:58:59 INFO - PROCESS | 11465 | |2;jquery.html;394.98222579983906;398.671096345515;406.457379398503;408.5750819148086;419.6249229361813;17931.641367172648;19360.3223887164;19424.708629370554;19448.319308824175;19726.408207753753;17243.827561724378;17978.460646180603;18130.728039079393;19229.134688938997;19229.4231173065;5421.051316019691;5486.177073438997;5550.611457197998;5583.8604034899045;5656.547476201894;5503.642263252896;5548.140038294071;5558.777648894039;5584.246126772895;5598;5362.753997625858;5518.806841760539;5550.111982082867;5555.638883472581;5614.438556144394;5584.553235741151;5591.860203494945;5595.468430499137;5619.719014049301;5637.774489020434;4780.521947805227;4905.117078925792;4932.8273510427325;4941;4947.406311242674;20731.585368292548;22052.338429847132;22122.22572209965;22140.446488837748;22220.11119555232;2372.644103384489;2467.1858286765505;2570.807189460798;2682.9268292682887;2822.8165169263934;10039.34744241622;10298.588056477733;10385;10530.736731581772;10586.311889727143;1996.2713609532561;2018.7880272571463;2047.5700102978244;2055.537315066305;2074.8236399906027;83239;85829.57085214533;85945.57027214886;86593;87378.12621873764;10885;11030.448477576088;11232.550697972152;11255.718607034725;11330.320180789015;15745.921270393575;15833.050016999017;15857.444989425314;15957;15980.76028859568;7858.332041776399;7917.920820791834;8077.071136819223;8088.514689118671;8152.796180095545;7447.88828167578;7551.282628150317;7586.013818203598;7646.541207527455;7719.150893401721;4656.604188643935;4680.368150299734;4743.952560474351;4785.090832741768;4787.497312782178;1931.94204173875;1947.7565304336958;1974.9703754443694;1984.9702254466195;1997.5106099005836;936.3352020065694;987.9753006174759;1027.984580231297;1045.6810672744734;1113.8551988241477;18919.97241462027;19472.318468853522;19481;19665.8033419664;19885.304014359426;987.5161171026289;996.5017491254373;1024.8718910136233;1041.3231399590327;1076.214363514623;10603.416812075257;10953.123750099972;11022.283551569122;11050.502727377287;11052.171087168334;524704;527541;528199;533109;535243;55069.44930550643;73974.63012684902;93394;96283;97730.5113474428;979.4270351844109;1006.5621454667097;1008.4705529596873;1047.7223535763028;1048.6958781953301;17744;17777.46667599974;17997.820021800137;18045.548861278574;18216.544586385447;40240.59759402485;40558;40894;40994.79502602468;41101;56672.43327566671;57035.42964570467;57258.713706431205;57442;58689.70655146697;8392.622331994953;8597.613107410056;8608.182222688834;8654.48073115615;8792.736217913218;6244.843878903063;8896.599653015759;13254.204747715168;13377;13431.261280629658;11311.208215424842;11733.530658773554;11773.941130294636;11796.174267801514;11842.763144736884;10859.37578077388;11382.94308528452;11448.82826757616;11476.598319058792;11734.354610496504;8774.868376974222;11792.587259445878;11862.347570883685;12225.388730563614;12227;8492.549912836766;8736.69421570242;8794.912050879666;8799.912000880166;8823.205911467741;10732;11460.65618031427;11538.134639901873;11538.826917596074;11740.941295293811 05:58:59 INFO - PROCESS | 11465 | |3;mootools.html;1514.6213446638344;1562.16424213046;1702.582867197536;1775.7869055713315;1813.4559632110363;7681.3086822186;8600.655973761042;8675;9246.676366327172;9269.351145419823;8652.870206946885;8881.200691937724;8900.198982091626;8900.821983560325;8912.598933048012;2355.399373159846;2424.6726691896633;2428.878556072198;2430.6597076409316;2436.6223235398543;2369.0286982337243;2375.9762402375927;2426.648136020276;2428.2836563213896;2432.1609044879488;2352.8588284702973;2358.0685629176464;2394.078279862248;2422.903083876643;2423.442608200115;2383.95232095358;2388.581998150317;2404.7955923746504;2419.2742177346813;2420.7942324902406;2370.099362242354;2377.3937645900187;2385.105585405473;2400;2403.8437501562516;8883.244924181452;8980.8652870207;8997.145271199226;9011.504367259799;9024.684136055206;5260.421353651095;5457.672539647634;5547.25112109864;5559.11054231321;5559.360673522516;3391.593008838955;3434.4676575130893;3499.3701133795907;3530.135116896351;3536.4341705327024;1115.8939900709502;1119.7144728094365;1134.7446824464512;1190.196617283339;1199.1126566340931;12394.876051239462;12483.126181167321;12510.18683785551;12524.37378131099;12533.93733031329;4570.063137056895;4588.220002599566;4686.625069994392;4702.224133018082;4762.333273341735;10492.790144197073;10522.526486308134;10542.051215390498;10552.41961692099;10587.89412105869;5274.92087618686;5292.206169074592;5306.681599104066;5318.149096144598;5323.600729945192;4359.193549193409;4753.287006948985;4913.263010548446;5029.446760856303;5070.264811602297;4027.2750904836826;4076.001379662002;4093.7953102344763;4150.875473735793;4224;1264.7533730922567;1281.4233594882153;1290.0324756432676;1304.6086174147908;1333.953311634088;964.2912459342377;977.1596427072711;988.6292640259902;993.6571882700457;995.6664517386612;5925.940740592625;5926.318473375531;5961.4038596140035;6047.334793172836;6089.543284253698;466.34711404034624;470.76226505614443;474.1986043586328;1002.5989604158395;1046.984295235572;4187.246295666749;4239.660827133822;4256.808443620044;4257.382679511454;4266.168097221012;10351.06840384369;10573.2598718089;10685.732856678489;10732.839007414896;10747.086497647788;10424.061834434937;10453.425061621532;10457.058864702061;10493.317934334244;10498.737531561772;7406.925930740731;7659.8127290268985;8307.792305192297;8488.957555212308;8535.146485351415;5961.612495187799;6023;6029.517638588814;6049.637021778707;6114.969425152845;10048.296619236875;10258.897411026093;10260.538275777757;10270.07569318765;10307.639232626821;10066.245031622511;10213.489325533843;10238.12975897057;10323;10388.324758890649;6890.896636550356;7476.850462990818;7556.886646700414;7693.038370203724;7770.689172433039;8760.518171500375;8820.162084601952;8823.426477278956;8834.602442889956;8868.467891926504;7380.298871607189;7483.850322993619;7507.061617297838;7633.847323053619;7730.149683534694;7712.845743084995;7775.339096176888;7785.299323060952;7808.804779880548;8047.637856296597;7404.888926665996;7472.663730132266;7489.588072656056;7500.474966752275;7503.212162722835;5083.135866902561;5184.351956005499;5224.164133738584;5295.735213239245;5324.520793128482;5071.264666623245;5124.1032819257225;5140.100482415637;5240.737963101906;5302.734863256745 05:58:59 INFO - PROCESS | 11465 | |4;prototype.html;332.5244899793296;334.40142145559435;337.5510570940649;345.5922012025812;346.2054584728049;5582.162675598663;5613.719314034297;5660.462256085676;5715.371309155989;5758.683272420026;5504.2018907258525;5534.280543529346;5555.611107222496;5555.999840057576;5572.275604171452;4146.564610715869;4222.746635201897;4352.238358287287;4355.586219309161;4372.032585336596;4309.784510774464;4314.360542993673;4329.242382583051;4343.283358245885;4366;4342.196693611676;4345.435093437849;4359.910022494377;4365.253898440633;4369.803358848843;4256.34026725858;4336.067745434715;4336.262835318003;4350.956490435086;4356.257497001193;3838.2707285615643;3841.1741475582603;3844.6539811417106;3848.749831260987;3871.341871881759;5377.7580008899695;5395;5406.83779486616;5410.783568657288;5424.647397919122;4823.807047718087;4978.427480839714;4979;4997.800087996512;5030.748462576893;5771.913421298684;5773.884522309572;5813.709314534256;5815.400764789674;5827.6887700267525;4222.19778242133;4234.830606775725;4262.808173632194;4292.356146578007;4293.0340673348555;5738.626989245686;5915.674637894871;6046.395360463963;6049.5462840287155;6090.299615544225;4157.711109556048;4198.3702444633545;4216.810243539048;4225.239456897788;4231.703780735319;4271.124419493996;4274.807633656493;4281.143771245701;4284.500424851277;4284.742915425085;4767.475577686451;4934.827281045146;4939.481354457802;4966.801327946841;4972.950270497321;5835.2122463466885;5861.095144078192;5863.384344643836;5865.736041878125;5875.618084824473;1451.0350616839683;1463.2244910197612;1466.3474753734486;1476.5644134980207;1487.293535570617;928.7399528132133;940.5391358234552;941.75985123793;945.4516380499294;954.5084281594984;4992.400911890524;5035.874103147451;5057.443681195065;5069.721165335942;5072.898542029213;5313.8937221255355;5372.8656783579945;5391.35303763543;5461.726913654302;5473.808416705396;5132.79468821243;5152.604039121827;5283.762230699628;5770.913436298459;5790.826275211751;3221.7261532769976;3248.6101667799544;3254.6419893811662;3284.507323901386;3287.309664970383;6169.5064394848305;6210.658413787285;6261;6290.766777793909;6296.866564018429;6150.753969841246;6188.350223226586;6225.3774622537385;6229.501639868799;6253.468455181361;6256.186695729526;6261.217347831521;6285.051633993477;6308.779192728324;6315.010771606929;5848.561357898089;6089.695515224133;6108.541859360655;6166.105914642441;6188.1027251049245;5936.406359364029;6008.158857760004;6032.155498230163;6054.243219597551;6079.513638908788;5881.676622759845;6243.500519958483;6245.3754624539;6248.218972628421;6254.21822272216;4220.810063547209;4266.146770645822;4278.358246263086;4293.549177336459;4310.396544483712;5880.8235752927485;5935.109733540004;6139.877202456015;6155.72299246526;6159.628543010884;5917.822465326047;5918.816236752753;5954.880902382015;5958.1360702697;5970.432808883149;5842.824715258549;5873.500752436091;5882.617629854046;5902.6458412495385;5974.37269086757;5580.693061881636;5780.393058728773;5790.334111577054;5794.333651629948;5810.767569297181;5926.970365148147;5939.613925094855;5957;5976.970115149396;6005.849853753691;5669.6314739541795;5785.161151633074;5810.564207684525;5827.213326201078;5861.472467477777 05:58:59 INFO - PROCESS | 11465 | |5;yui.html;760.8250102476434;764.3846703403759;771.6527562596833;811.9837603247937;863.8358711844753;15018.774718379233;16202.108884011375;16220.837791622094;16291.755623665626;16295.918520407411;14428.062175958556;14435.133891966489;14474.42102315906;14591.197484138394;14597.78103328451;663.8174502011962;803.036356372354;814.2468216899374;816.8652172391548;817.1297568089965;780.0561320801837;802.4102284820652;805.5972013993004;809.8785182222684;810.8378324335127;846.7713717296326;853.4495250563383;859.5358506406533;860.3031544448985;861.5261606116642;845.6110189312924;851.0128251228607;852.2627926843298;855.2345650642671;855.3883972959333;617.4288782875867;620.6710443464971;621.6518749500249;623.5977794322637;624.3662682377391;14140.080894741808;14145;14162.716745665131;14169.433222671081;14173.85826141746;15123.697526049418;15171.468998584996;15336.616584585363;15383.230838458145;15448.227588620524;12430.440630171574;12565.18326308787;12603.74792504154;12650.177738446971;12770.361481925867;3903.6291552302487;3918.725689201757;3992.401139829049;4049.2306461772464;4137.2552940470705;75764;76089.61955190188;76276.61861690712;79440;79801;11853.76292474163;11873.228240164362;11926.986206172573;12045.578404755966;12191.573294934813;22333.10667573279;22472.775272247396;22544.887275563844;22601.09595616157;22619;8502.107278735768;8506.276966457797;8836.734897953073;8846.646134154691;9157.587908544132;4690.15577196108;4747.359106520645;4785.784639691222;4786.1863483207935;4924.926126108111;3391.3217356528794;3444.7943219872845;3467.150548115728;3483.076984599083;3511.6839484446523;558.8295569851153;565.6069032022705;569.3879079989028;572.2589246925241;579.7217335678898;771.9266669666373;772.9729459468891;774.3611520495614;778.8636988526985;810.7567729681072;10266.691999240034;10498.737531561772;10547.630832920811;10619.84070238947;10728.498010278567;602.0703644818346;653.4054010850103;732.6190381001849;752.3417010116149;765.5215490318551;4745.9050818984115;4883.731394773322;4919.385076865392;4927.211646136601;4954.727489988013;70046;100150;121115;122106.38946805387;123577;66146.33853661401;68196;102668.48665756623;102848;105092.47453762683;89114.55442722744;91558;91647;91912;92006.07993919976;9550.95224523873;9553.379030363005;9567.569459374206;9709.223262139154;9760.707178784647;36581.817090914374;40672.59327406688;52700.472995269556;53053;53686.46313536971;72746.63626681833;79265;80178.59910700642;81927;82814.58592707239;11119.555217791521;11590.594329198437;12761.234325940473;13068.54260100892;13523.391447385087;14408.783868242195;14595.416183352547;14838.925805370904;14866.658382005717;15661;14039.649008774863;14236.644083897985;14237.430502780187;14242.28788560547;14362;13953.302334883418;13979.650508737363;14408.20754858493;14450.85549144495;14470.625290597376;11469.155601597713;11592.942035289769;11881.524739010343;11934.403279836148;11961;10320.015148645945;11071.944640276746;11114.49984750672;11114.555417783198;11531.358462353386;11923;12082.75834483323;12141.57504487374;12226;12487.687807804878 05:58:59 INFO - PROCESS | 11465 | __end_tp_report 05:58:59 INFO - PROCESS | 11465 | __start_cc_report 05:58:59 INFO - PROCESS | 11465 | _x_x_mozilla_cycle_collect,347 05:58:59 INFO - PROCESS | 11465 | __end_cc_report 05:58:59 INFO - PROCESS | 11465 | __startTimestamp1465045139111__endTimestamp 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | ------- Summary: start ------- 05:58:59 INFO - PROCESS | 11465 | Number of tests: 6 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#0] dojo.html Cycles:165 Average:5485.47 Median:5681.91 stddev:736.06 (13.0%) stddev-sans-first:715.31 05:58:59 INFO - PROCESS | 11465 | Values: 3158.0 3169.1 3178.6 3180.4 3198.6 5387.0 5429.9 5475.6 5499.6 5502.6 5446.8 5467.9 5469.0 5532.9 5543.1 5070.4 5096.8 5151.4 5174.6 5241.2 709.5 4994.3 5072.0 5129.3 5159.4 5106.7 5112.3 5143.9 5152.0 5157.1 5144.4 5155.9 5158.1 5170.8 5219.4 4971.7 5044.4 5070.7 5103.7 5114.0 5510.1 5529.4 5530.1 5531.4 5573.8 5833.1 6030.9 6037.9 6045.1 6058.8 5874.2 5881.5 5915.5 5957.4 5963.1 5519.2 5552.8 5565.9 5572.7 5580.7 5823.9 6040.4 6093.3 6097.1 6106.1 5865.1 5865.6 5914.1 5945.3 5973.1 6001.8 6004.5 6016.1 6016.4 6017.3 5751.3 5876.4 5884.8 5921.7 5993.8 5919.6 5977.6 5980.7 6000.6 6043.0 4479.3 4493.2 4496.0 4503.8 4554.5 3903.7 3987.9 4002.9 4071.7 4081.9 5503.6 5556.0 5575.6 5594.5 5676.2 5973.9 6047.3 6051.7 6085.9 6093.7 5510.6 5542.0 5569.7 5600.5 5693.8 4896.6 4898.4 4900.5 4902.7 4916.0 6088.7 6088.8 6113.2 6113.2 6118.1 5818.4 5933.7 5948.4 5963.9 5984.4 6104.5 6113.2 6120.8 6130.7 6150.5 5718.7 5842.9 5885.3 5893.8 5897.6 5898.3 5935.9 5976.0 5997.9 6008.8 5753.3 5790.2 5801.3 5843.3 5859.7 5681.9 5748.7 5810.7 5833.4 5838.0 5596.1 5646.5 5648.1 5657.8 5675.9 5757.5 5815.2 5839.8 5843.1 5857.9 5585.4 5675.5 5680.8 5681.0 5715.5 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#1] ext.html Cycles:180 Average:61325.72 Median:41041.19 stddev:126863.37 (309.1%) stddev-sans-first:127137.20 05:58:59 INFO - PROCESS | 11465 | Values: 551.7 602.1 612.5 618.1 647.2 38676.2 44368.3 44423.1 44442.0 44496.6 44177.3 45028.0 45101.5 45179.0 45258.0 8725.8 8783.7 8837.6 8885.6 8901.1 8774.9 8797.0 8874.2 8874.7 8874.9 8900.9 8910.0 8928.4 8934.3 8943.5 8859.7 8868.9 8938.4 8942.9 8948.5 8851.5 8943.0 8943.9 8944.8 8949.0 40273.8 40826.4 40865.6 41094.8 41150.8 3712.9 3724.2 3757.7 3821.8 3878.5 32821.2 33090.8 33216.0 33513.3 34028.3 4294.0 4371.8 4383.6 4405.1 4498.1 353655.0 354328.0 356266.0 356771.0 357128.0 34318.1 34981.8 60572.7 61666.7 61820.0 37117.0 37213.8 37505.8 37526.2 37542.2 14391.3 14401.6 14574.2 14618.6 14622.4 12085.5 12196.7 12249.1 12281.1 12305.4 8352.0 8387.6 8471.7 8520.9 8537.5 3235.6 3271.2 3282.1 3297.3 3333.5 1008.9 1035.6 1099.4 1161.6 1227.3 31575.0 32112.8 32125.5 32461.4 32640.3 1125.0 1167.4 1181.9 1192.1 1258.4 16220.7 16852.2 17020.8 17109.0 17310.4 549765.0 555217.0 561471.0 562651.0 568513.0 57158.4 58338.0 58405.0 58481.4 58559.0 1333.1 1384.3 1391.7 1396.1 1399.9 30988.2 31884.0 31920.2 32082.2 32393.5 48980.8 49998.0 50081.0 50084.0 50155.0 484605.0 492735.0 493236.0 493476.0 493725.0 28443.4 28819.9 29047.7 29100.9 29177.7 47810.0 48068.8 48968.8 49065.5 49338.8 40385.6 41118.8 41572.6 42253.8 42830.8 39084.0 40987.6 41540.0 41546.0 41858.0 36153.0 40752.6 41585.8 42562.4 42741.4 33768.7 36474.8 36860.3 37361.3 37470.4 28601.6 28729.6 28849.7 29010.3 29119.6 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#2] jquery.html Cycles:180 Average:29831.70 Median:2752.87 stddev:87126.99 (3164.9%) stddev-sans-first:87343.37 05:58:59 INFO - PROCESS | 11465 | Values: 395.0 398.7 406.5 408.6 419.6 17931.6 19360.3 19424.7 19448.3 19726.4 17243.8 17978.5 18130.7 19229.1 19229.4 5421.1 5486.2 5550.6 5583.9 5656.5 5503.6 5548.1 5558.8 5584.2 5598.0 5362.8 5518.8 5550.1 5555.6 5614.4 5584.6 5591.9 5595.5 5619.7 5637.8 4780.5 4905.1 4932.8 4941.0 4947.4 20731.6 22052.3 22122.2 22140.4 22220.1 2372.6 2467.2 2570.8 2682.9 2822.8 10039.3 10298.6 10385.0 10530.7 10586.3 1996.3 2018.8 2047.6 2055.5 2074.8 83239.0 85829.6 85945.6 86593.0 87378.1 10885.0 11030.4 11232.6 11255.7 11330.3 15745.9 15833.1 15857.4 15957.0 15980.8 7858.3 7917.9 8077.1 8088.5 8152.8 7447.9 7551.3 7586.0 7646.5 7719.2 4656.6 4680.4 4744.0 4785.1 4787.5 1931.9 1947.8 1975.0 1985.0 1997.5 936.3 988.0 1028.0 1045.7 1113.9 18920.0 19472.3 19481.0 19665.8 19885.3 987.5 996.5 1024.9 1041.3 1076.2 10603.4 10953.1 11022.3 11050.5 11052.2 524704.0 527541.0 528199.0 533109.0 535243.0 55069.4 73974.6 93394.0 96283.0 97730.5 979.4 1006.6 1008.5 1047.7 1048.7 17744.0 17777.5 17997.8 18045.5 18216.5 40240.6 40558.0 40894.0 40994.8 41101.0 56672.4 57035.4 57258.7 57442.0 58689.7 8392.6 8597.6 8608.2 8654.5 8792.7 6244.8 8896.6 13254.2 13377.0 13431.3 11311.2 11733.5 11773.9 11796.2 11842.8 10859.4 11382.9 11448.8 11476.6 11734.4 8774.9 11792.6 11862.3 12225.4 12227.0 8492.5 8736.7 8794.9 8799.9 8823.2 10732.0 11460.7 11538.1 11538.8 11740.9 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#3] mootools.html Cycles:180 Average:5851.70 Median:2576.49 stddev:3289.42 (127.7%) stddev-sans-first:3282.50 05:58:59 INFO - PROCESS | 11465 | Values: 1514.6 1562.2 1702.6 1775.8 1813.5 7681.3 8600.7 8675.0 9246.7 9269.4 8652.9 8881.2 8900.2 8900.8 8912.6 2355.4 2424.7 2428.9 2430.7 2436.6 2369.0 2376.0 2426.6 2428.3 2432.2 2352.9 2358.1 2394.1 2422.9 2423.4 2384.0 2388.6 2404.8 2419.3 2420.8 2370.1 2377.4 2385.1 2400.0 2403.8 8883.2 8980.9 8997.1 9011.5 9024.7 5260.4 5457.7 5547.3 5559.1 5559.4 3391.6 3434.5 3499.4 3530.1 3536.4 1115.9 1119.7 1134.7 1190.2 1199.1 12394.9 12483.1 12510.2 12524.4 12533.9 4570.1 4588.2 4686.6 4702.2 4762.3 10492.8 10522.5 10542.1 10552.4 10587.9 5274.9 5292.2 5306.7 5318.1 5323.6 4359.2 4753.3 4913.3 5029.4 5070.3 4027.3 4076.0 4093.8 4150.9 4224.0 1264.8 1281.4 1290.0 1304.6 1334.0 964.3 977.2 988.6 993.7 995.7 5925.9 5926.3 5961.4 6047.3 6089.5 466.3 470.8 474.2 1002.6 1047.0 4187.2 4239.7 4256.8 4257.4 4266.2 10351.1 10573.3 10685.7 10732.8 10747.1 10424.1 10453.4 10457.1 10493.3 10498.7 7406.9 7659.8 8307.8 8489.0 8535.1 5961.6 6023.0 6029.5 6049.6 6115.0 10048.3 10258.9 10260.5 10270.1 10307.6 10066.2 10213.5 10238.1 10323.0 10388.3 6890.9 7476.9 7556.9 7693.0 7770.7 8760.5 8820.2 8823.4 8834.6 8868.5 7380.3 7483.9 7507.1 7633.8 7730.1 7712.8 7775.3 7785.3 7808.8 8047.6 7404.9 7472.7 7489.6 7500.5 7503.2 5083.1 5184.4 5224.2 5295.7 5324.5 5071.3 5124.1 5140.1 5240.7 5302.7 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#4] prototype.html Cycles:180 Average:4905.39 Median:5555.81 stddev:1454.05 (26.2%) stddev-sans-first:1417.04 05:58:59 INFO - PROCESS | 11465 | Values: 332.5 334.4 337.6 345.6 346.2 5582.2 5613.7 5660.5 5715.4 5758.7 5504.2 5534.3 5555.6 5556.0 5572.3 4146.6 4222.7 4352.2 4355.6 4372.0 4309.8 4314.4 4329.2 4343.3 4366.0 4342.2 4345.4 4359.9 4365.3 4369.8 4256.3 4336.1 4336.3 4351.0 4356.3 3838.3 3841.2 3844.7 3848.7 3871.3 5377.8 5395.0 5406.8 5410.8 5424.6 4823.8 4978.4 4979.0 4997.8 5030.7 5771.9 5773.9 5813.7 5815.4 5827.7 4222.2 4234.8 4262.8 4292.4 4293.0 5738.6 5915.7 6046.4 6049.5 6090.3 4157.7 4198.4 4216.8 4225.2 4231.7 4271.1 4274.8 4281.1 4284.5 4284.7 4767.5 4934.8 4939.5 4966.8 4973.0 5835.2 5861.1 5863.4 5865.7 5875.6 1451.0 1463.2 1466.3 1476.6 1487.3 928.7 940.5 941.8 945.5 954.5 4992.4 5035.9 5057.4 5069.7 5072.9 5313.9 5372.9 5391.4 5461.7 5473.8 5132.8 5152.6 5283.8 5770.9 5790.8 3221.7 3248.6 3254.6 3284.5 3287.3 6169.5 6210.7 6261.0 6290.8 6296.9 6150.8 6188.4 6225.4 6229.5 6253.5 6256.2 6261.2 6285.1 6308.8 6315.0 5848.6 6089.7 6108.5 6166.1 6188.1 5936.4 6008.2 6032.2 6054.2 6079.5 5881.7 6243.5 6245.4 6248.2 6254.2 4220.8 4266.1 4278.4 4293.5 4310.4 5880.8 5935.1 6139.9 6155.7 6159.6 5917.8 5918.8 5954.9 5958.1 5970.4 5842.8 5873.5 5882.6 5902.6 5974.4 5580.7 5780.4 5790.3 5794.3 5810.8 5927.0 5939.6 5957.0 5977.0 6005.8 5669.6 5785.2 5810.6 5827.2 5861.5 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - PROCESS | 11465 | [#5] yui.html Cycles:180 Average:20623.69 Median:4020.82 stddev:29466.95 (732.9%) stddev-sans-first:29511.86 05:58:59 INFO - PROCESS | 11465 | Values: 760.8 764.4 771.7 812.0 863.8 15018.8 16202.1 16220.8 16291.8 16295.9 14428.1 14435.1 14474.4 14591.2 14597.8 663.8 803.0 814.2 816.9 817.1 780.1 802.4 805.6 809.9 810.8 846.8 853.4 859.5 860.3 861.5 845.6 851.0 852.3 855.2 855.4 617.4 620.7 621.7 623.6 624.4 14140.1 14145.0 14162.7 14169.4 14173.9 15123.7 15171.5 15336.6 15383.2 15448.2 12430.4 12565.2 12603.7 12650.2 12770.4 3903.6 3918.7 3992.4 4049.2 4137.3 75764.0 76089.6 76276.6 79440.0 79801.0 11853.8 11873.2 11927.0 12045.6 12191.6 22333.1 22472.8 22544.9 22601.1 22619.0 8502.1 8506.3 8836.7 8846.6 9157.6 4690.2 4747.4 4785.8 4786.2 4924.9 3391.3 3444.8 3467.2 3483.1 3511.7 558.8 565.6 569.4 572.3 579.7 771.9 773.0 774.4 778.9 810.8 10266.7 10498.7 10547.6 10619.8 10728.5 602.1 653.4 732.6 752.3 765.5 4745.9 4883.7 4919.4 4927.2 4954.7 70046.0 100150.0 121115.0 122106.4 123577.0 66146.3 68196.0 102668.5 102848.0 105092.5 89114.6 91558.0 91647.0 91912.0 92006.1 9551.0 9553.4 9567.6 9709.2 9760.7 36581.8 40672.6 52700.5 53053.0 53686.5 72746.6 79265.0 80178.6 81927.0 82814.6 11119.6 11590.6 12761.2 13068.5 13523.4 14408.8 14595.4 14838.9 14866.7 15661.0 14039.6 14236.6 14237.4 14242.3 14362.0 13953.3 13979.7 14408.2 14450.9 14470.6 11469.2 11592.9 11881.5 11934.4 11961.0 10320.0 11071.9 11114.5 11114.6 11531.4 11923.0 12082.8 12141.6 12226.0 12487.7 05:58:59 INFO - PROCESS | 11465 | -------- Summary: end -------- 05:58:59 INFO - PROCESS | 11465 | 05:58:59 INFO - TEST-INFO | 11465: exit 0 05:58:59 INFO - TEST-OK | dromaeo_css | took 1112115ms 05:58:59 INFO - TEST-START | kraken 05:58:59 INFO - operating with platform_type : linux_ 05:58:59 INFO - Initialising browser for kraken test... 05:58:59 INFO - TEST-INFO | started process 11694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbAV6k1/profile http://localhost:58885/getInfo.html) 05:59:05 INFO - PROCESS | 11694 | __metrics Screen width/height:1600/1200 05:59:05 INFO - PROCESS | 11694 | colorDepth:24 05:59:05 INFO - PROCESS | 11694 | Browser inner width/height: 1024/697 05:59:05 INFO - PROCESS | 11694 | __metrics 05:59:06 ERROR - PROCESS | 11694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:59:07 INFO - TEST-INFO | 11694: exit 0 05:59:07 INFO - Browser initialized. 05:59:07 INFO - Running cycle 1/1 for kraken test... 05:59:07 INFO - TEST-INFO | started process 11813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbAV6k1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:18 INFO - PROCESS | 11813 | RSS: Main: 167321600 05:59:18 INFO - PROCESS | 11813 | 05:59:21 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58885/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:22 INFO - PROCESS | 11813 | RSS: Main: 172638208 05:59:22 INFO - PROCESS | 11813 | 05:59:24 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58885/tests/kraken/driver.html?testName=audio-dft) 05:59:25 INFO - PROCESS | 11813 | RSS: Main: 172277760 05:59:25 INFO - PROCESS | 11813 | 05:59:28 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58885/tests/kraken/driver.html?testName=audio-fft) 05:59:29 INFO - PROCESS | 11813 | RSS: Main: 167251968 05:59:29 INFO - PROCESS | 11813 | 05:59:31 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58885/tests/kraken/driver.html?testName=audio-oscillator) 05:59:32 INFO - PROCESS | 11813 | RSS: Main: 168378368 05:59:32 INFO - PROCESS | 11813 | 05:59:34 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:34 INFO - PROCESS | 11813 | RSS: Main: 168513536 05:59:34 INFO - PROCESS | 11813 | 05:59:37 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58885/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:38 INFO - PROCESS | 11813 | RSS: Main: 168759296 05:59:38 INFO - PROCESS | 11813 | 05:59:41 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58885/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:42 INFO - PROCESS | 11813 | RSS: Main: 168611840 05:59:42 INFO - PROCESS | 11813 | 05:59:45 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58885/tests/kraken/driver.html?testName=json-parse-financial) 05:59:46 INFO - PROCESS | 11813 | RSS: Main: 168693760 05:59:46 INFO - PROCESS | 11813 | 05:59:47 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:48 INFO - PROCESS | 11813 | RSS: Main: 168828928 05:59:48 INFO - PROCESS | 11813 | 05:59:50 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:50 INFO - PROCESS | 11813 | RSS: Main: 169021440 05:59:50 INFO - PROCESS | 11813 | 05:59:52 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:53 INFO - PROCESS | 11813 | RSS: Main: 169807872 05:59:53 INFO - PROCESS | 11813 | 05:59:56 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:56 INFO - PROCESS | 11813 | RSS: Main: 169877504 05:59:56 INFO - PROCESS | 11813 | 05:59:59 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:00 INFO - PROCESS | 11813 | RSS: Main: 169754624 06:00:00 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | Cycle 1(1): loaded http://localhost:58885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58885/tests/kraken/driver.html?testName=ai-astar) 06:00:01 INFO - PROCESS | 11813 | RSS: Main: 170438656 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | __start_tp_report 06:00:01 INFO - PROCESS | 11813 | _x_x_mozilla_page_load 06:00:01 INFO - PROCESS | 11813 | _x_x_mozilla_page_load_details 06:00:01 INFO - PROCESS | 11813 | |i|pagename|runs| 06:00:01 INFO - PROCESS | 11813 | |0;ai-astar;113;105;111;112;113;114;112;112;113;110 06:00:01 INFO - PROCESS | 11813 | |1;audio-beat-detection;157;129;157;178;128;157;160;129;179;128 06:00:01 INFO - PROCESS | 11813 | |2;audio-dft;163;164;162;162;166;165;170;164;163;163 06:00:01 INFO - PROCESS | 11813 | |3;audio-fft;77;75;75;160;75;75;75;75;162;75 06:00:01 INFO - PROCESS | 11813 | |4;audio-oscillator;84;83;150;85;84;85;153;83;83;138 06:00:01 INFO - PROCESS | 11813 | |5;imaging-gaussian-blur;117;117;118;116;118;116;118;118;118;117 06:00:01 INFO - PROCESS | 11813 | |6;imaging-darkroom;146;146;146;150;147;147;148;148;147;147 06:00:01 INFO - PROCESS | 11813 | |7;imaging-desaturate;98;96;96;95;97;95;95;96;96;95 06:00:01 INFO - PROCESS | 11813 | |8;json-parse-financial;57;55;60;55;55;56;54;55;54;57 06:00:01 INFO - PROCESS | 11813 | |9;json-stringify-tinderbox;60;60;60;61;61;61;61;62;61;61 06:00:01 INFO - PROCESS | 11813 | |10;stanford-crypto-aes;80;82;85;87;80;81;88;80;103;80 06:00:01 INFO - PROCESS | 11813 | |11;stanford-crypto-ccm;123;122;126;129;121;125;129;132;148;132 06:00:01 INFO - PROCESS | 11813 | |12;stanford-crypto-pbkdf2;163;166;163;163;164;167;166;168;161;163 06:00:01 INFO - PROCESS | 11813 | |13;stanford-crypto-sha256-iterative;68;63;66;63;64;63;66;62;66;62 06:00:01 INFO - PROCESS | 11813 | __end_tp_report 06:00:01 INFO - PROCESS | 11813 | __start_cc_report 06:00:01 INFO - PROCESS | 11813 | _x_x_mozilla_cycle_collect,889 06:00:01 INFO - PROCESS | 11813 | __end_cc_report 06:00:01 INFO - PROCESS | 11813 | __startTimestamp1465045201965__endTimestamp 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | ------- Summary: start ------- 06:00:01 INFO - PROCESS | 11813 | Number of tests: 14 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.55 (2.3%) stddev-sans-first:2.65 06:00:01 INFO - PROCESS | 11813 | Values: 113.0 105.0 111.0 112.0 113.0 114.0 112.0 112.0 113.0 110.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:20.33 (13.0%) stddev-sans-first:21.42 06:00:01 INFO - PROCESS | 11813 | Values: 157.0 129.0 157.0 178.0 128.0 157.0 160.0 129.0 179.0 128.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.39 (1.5%) stddev-sans-first:2.50 06:00:01 INFO - PROCESS | 11813 | Values: 163.0 164.0 162.0 162.0 166.0 165.0 170.0 164.0 163.0 163.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.16 (48.2%) stddev-sans-first:37.93 06:00:01 INFO - PROCESS | 11813 | Values: 77.0 75.0 75.0 160.0 75.0 75.0 75.0 75.0 162.0 75.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:83.50 stddev:30.74 (36.8%) stddev-sans-first:31.84 06:00:01 INFO - PROCESS | 11813 | Values: 84.0 83.0 150.0 85.0 84.0 85.0 153.0 83.0 83.0 138.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 06:00:01 INFO - PROCESS | 11813 | Values: 117.0 117.0 118.0 116.0 118.0 116.0 118.0 118.0 118.0 117.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 06:00:01 INFO - PROCESS | 11813 | Values: 146.0 146.0 146.0 150.0 147.0 147.0 148.0 148.0 147.0 147.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:0.71 06:00:01 INFO - PROCESS | 11813 | Values: 98.0 96.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.81 (3.3%) stddev-sans-first:1.87 06:00:01 INFO - PROCESS | 11813 | Values: 57.0 55.0 60.0 55.0 55.0 56.0 54.0 55.0 54.0 57.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 06:00:01 INFO - PROCESS | 11813 | Values: 60.0 60.0 60.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.50 stddev:7.15 (8.8%) stddev-sans-first:7.39 06:00:01 INFO - PROCESS | 11813 | Values: 80.0 82.0 85.0 87.0 80.0 81.0 88.0 80.0 103.0 80.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.00 stddev:7.83 (6.1%) stddev-sans-first:8.03 06:00:01 INFO - PROCESS | 11813 | Values: 123.0 122.0 126.0 129.0 121.0 125.0 129.0 132.0 148.0 132.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:2.22 (1.3%) stddev-sans-first:2.30 06:00:01 INFO - PROCESS | 11813 | Values: 163.0 166.0 163.0 163.0 164.0 167.0 166.0 168.0 161.0 163.0 06:00:01 INFO - PROCESS | 11813 | 06:00:01 INFO - PROCESS | 11813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:2.06 (3.2%) stddev-sans-first:1.69 06:00:01 INFO - PROCESS | 11813 | Values: 68.0 63.0 66.0 63.0 64.0 63.0 66.0 62.0 66.0 62.0 06:00:01 INFO - PROCESS | 11813 | -------- Summary: end -------- 06:00:01 INFO - PROCESS | 11813 | 06:00:02 INFO - TEST-INFO | 11813: exit 0 06:00:02 INFO - TEST-OK | kraken | took 63083ms 06:00:02 INFO - SUITE-END | took 1175s 06:00:03 INFO - Completed test suite (00:19:35) 06:00:03 INFO - javascript benchmark 06:00:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7288.283908582385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3157.9526307105384, 3169.1126484584315, 3178.6344570374413, 3180.363927214557, 3198.584184056074, 5387.0, 5429.864253393667, 5475.616706830523, 5499.642523235987, 5502.642328248671, 5446.836594902149, 5467.863303417416, 5469.042917489433, 5532.889342213153, 5543.057680194366, 5070.391553013644, 5096.79612815487, 5151.4075881273575, 5174.586033117342, 5241.161414173733, 709.4682602696531, 4994.300797888299, 5072.0, 5129.2562578426105, 5159.432462429129, 5106.66806657566, 5112.335396398463, 5143.871403214912, 5152.0, 5157.123289040854, 5144.382674079135, 5155.871103222412, 5158.071547121516, 5170.767315470813, 5219.373675158968, 4971.651984361096, 5044.39467263927, 5070.746462676888, 5103.693778373309, 5114.0, 5510.090835012218, 5529.364123125812, 5530.059889818741, 5531.419200983879, 5573.832785016456, 5833.06670932653, 6030.879382412371, 6037.879242415171, 6045.063015232646, 6058.787942421994, 5874.177615133842, 5881.500072493843, 5915.526757859361, 5957.374475680078, 5963.13534537494, 5519.199716041152, 5552.805651802208, 5565.916511252334, 5572.749226284786, 5580.748866300985, 5823.912641310384, 6040.365761595057, 6093.329733729286, 6097.115918191837, 6106.145139680449, 5865.120231965239, 5865.560082993792, 5914.142449344907, 5945.346011938684, 5973.1338955852025, 6001.849953751103, 6004.519638428916, 6016.127661489059, 6016.368281330398, 6017.2779266488305, 5751.252337196138, 5876.3536011039605, 5884.7940322088525, 5921.73352199152, 5993.820185394445, 5919.585629005928, 5977.641341519523, 5980.700964951735, 6000.639961602318, 6043.033114701714, 4479.260921947842, 4493.168763778712, 4495.955040449619, 4503.797329120198, 4554.476235232991, 3903.746256493319, 3987.900302492461, 4002.8598999034893, 4071.694622903294, 4081.9387709184384, 5503.559715222773, 5555.972220138873, 5575.637583557056, 5594.468525490072, 5676.2337084493065, 5973.850653733692, 6047.274327080779, 6051.697415129314, 6085.939140608537, 6093.664848433379, 5510.586705997066, 5541.972290138604, 5569.66582005081, 5600.4959553640365, 5693.829185124453, 4896.632752543503, 4898.387701537308, 4900.485449027872, 4902.705837649681, 4916.041371932511, 6088.695565221721, 6088.756449742049, 6113.205283313141, 6113.20528331323, 6118.1128736332985, 5818.359980402152, 5933.732982015733, 5948.434898684618, 5963.850903727268, 5984.401559843981, 6104.450599445893, 6113.23584551931, 6120.785772497941, 6130.724117414817, 6150.538709596709, 5718.714064296852, 5842.912356314574, 5885.323187833454, 5893.793717219876, 5897.5576831736935, 5898.3216930053595, 5935.881282374242, 5976.043832986701, 5997.850053748692, 6008.849778755566, 5753.309602847685, 5790.189373487631, 5801.332846722512, 5843.2695913010875, 5859.677717725566, 5681.9147712783515, 5748.655080695172, 5810.709464526842, 5833.445822646841, 5838.007538718513, 5596.104623260258, 5646.520045796154, 5648.124540696034, 5657.773689052392, 5675.914861277001, 5757.453041961007, 5815.244018277766, 5839.824805255849, 5843.065109582616, 5857.912131318119, 5585.385607583244, 5675.517581005661, 5680.829575112753, 5680.971595141998, 5715.485606295453], "value": 5437.056494400529, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.6634852739828, 602.0607851751269, 612.5038718637903, 618.072890664004, 647.207171215261, 38676.226475470474, 44368.33447498286, 44423.111537769226, 44442.0, 44496.555034449644, 44177.33733993985, 45028.0, 45101.54898451015, 45179.0, 45258.0, 8725.825483490325, 8783.73648790534, 8837.55812209387, 8885.600147993324, 8901.109889011112, 8774.868376974351, 8796.956015219946, 8874.245689116433, 8874.689385871496, 8874.911250887473, 8900.910990890074, 8909.955450222773, 8928.419652722552, 8934.329925255599, 8943.50810705411, 8859.689910853122, 8868.8669669955, 8938.374313798036, 8942.910570894273, 8948.507832069266, 8851.513166775825, 8943.016268210491, 8943.910560894437, 8944.821103577891, 8949.0, 40273.798631006954, 40826.38760418596, 40865.591344086475, 41094.79452602748, 41150.794246028876, 3712.888613341577, 3724.2179142380132, 3757.699384049297, 3821.847126114952, 3878.4764056852528, 32821.17947051319, 33090.834545827114, 33216.0, 33513.3297334052, 34028.31943361144, 4294.049702311626, 4371.781410929472, 4383.561643835623, 4405.140997505488, 4498.100379924028, 353655.0, 354328.0, 356266.0, 356771.0, 357128.0, 34318.14204644904, 34981.82509087438, 60572.697136514034, 61666.69166654138, 61820.0, 37117.0, 37213.813930930715, 37505.81247093747, 37526.24947501034, 37542.24915501675, 14391.28043597837, 14401.639959000899, 14574.198419087052, 14618.63453413652, 14622.415103395744, 12085.516579336903, 12196.695082622828, 12249.142560020713, 12281.140320177501, 12305.384730763426, 8352.0, 8387.62255698495, 8471.745847624581, 8520.8721869172, 8537.487750734852, 3235.5955505561806, 3271.214908422009, 3282.113829266085, 3297.2745995881346, 3333.4999750037687, 1008.9192864570816, 1035.5754140802235, 1099.395332567085, 1161.6456980620992, 1227.2636418149038, 31575.0, 32112.83943580267, 32125.51811722826, 32461.35077298441, 32640.347193056004, 1124.966251012471, 1167.371516734151, 1181.9231749936228, 1192.1416580062341, 1258.4211262819022, 16220.675586488203, 16852.15739213059, 17020.829791702174, 17109.0, 17310.394136205174, 549765.0, 555217.0, 561471.0, 562651.0, 568513.0, 57158.42841571531, 58338.0, 58405.0, 58481.41518584845, 58559.0, 1333.1134795360977, 1384.2870921475449, 1391.7286129204708, 1396.0925398490858, 1399.9160050397008, 30988.22529436782, 31884.0, 31920.201994950312, 32082.19794505156, 32393.51409728903, 48980.75509622429, 49998.0, 50080.998380031466, 50084.0, 50155.0, 484605.0, 492735.0, 493236.0, 493476.0, 493725.0, 28443.43113137767, 28819.855900720362, 29047.709522905345, 29100.854495727384, 29177.7082229175, 47810.0, 48068.759656201495, 48968.755156225416, 49065.509344906095, 49338.75330623324, 40385.59614403819, 41118.79440602778, 41572.58427415687, 42253.78873105615, 42830.78584607182, 39084.0, 40987.59012409838, 41540.0, 41546.0, 41858.0, 36153.0, 40752.59247407488, 41585.792071039454, 42562.361564575935, 42741.35887961621, 33768.66231337655, 36474.8176259117, 36860.26279474449, 37361.25277494489, 37470.43794343142, 28601.570976435785, 28729.56905646375, 28849.711502884704, 29010.274743130747, 29119.563206551495], "value": 19082.11980511952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.98222579983906, 398.671096345515, 406.457379398503, 408.5750819148086, 419.6249229361813, 17931.641367172648, 19360.3223887164, 19424.708629370554, 19448.319308824175, 19726.408207753753, 17243.827561724378, 17978.460646180603, 18130.728039079393, 19229.134688938997, 19229.4231173065, 5421.051316019691, 5486.177073438997, 5550.611457197998, 5583.8604034899045, 5656.547476201894, 5503.642263252896, 5548.140038294071, 5558.777648894039, 5584.246126772895, 5598.0, 5362.753997625858, 5518.806841760539, 5550.111982082867, 5555.638883472581, 5614.438556144394, 5584.553235741151, 5591.860203494945, 5595.468430499137, 5619.719014049301, 5637.774489020434, 4780.521947805227, 4905.117078925792, 4932.8273510427325, 4941.0, 4947.406311242674, 20731.585368292548, 22052.338429847132, 22122.22572209965, 22140.446488837748, 22220.11119555232, 2372.644103384489, 2467.1858286765505, 2570.807189460798, 2682.9268292682887, 2822.8165169263934, 10039.34744241622, 10298.588056477733, 10385.0, 10530.736731581772, 10586.311889727143, 1996.2713609532561, 2018.7880272571463, 2047.5700102978244, 2055.537315066305, 2074.8236399906027, 83239.0, 85829.57085214533, 85945.57027214886, 86593.0, 87378.12621873764, 10885.0, 11030.448477576088, 11232.550697972152, 11255.718607034725, 11330.320180789015, 15745.921270393575, 15833.050016999017, 15857.444989425314, 15957.0, 15980.76028859568, 7858.332041776399, 7917.920820791834, 8077.071136819223, 8088.514689118671, 8152.796180095545, 7447.88828167578, 7551.282628150317, 7586.013818203598, 7646.541207527455, 7719.150893401721, 4656.604188643935, 4680.368150299734, 4743.952560474351, 4785.090832741768, 4787.497312782178, 1931.94204173875, 1947.7565304336958, 1974.9703754443694, 1984.9702254466195, 1997.5106099005836, 936.3352020065694, 987.9753006174759, 1027.984580231297, 1045.6810672744734, 1113.8551988241477, 18919.97241462027, 19472.318468853522, 19481.0, 19665.8033419664, 19885.304014359426, 987.5161171026289, 996.5017491254373, 1024.8718910136233, 1041.3231399590327, 1076.214363514623, 10603.416812075257, 10953.123750099972, 11022.283551569122, 11050.502727377287, 11052.171087168334, 524704.0, 527541.0, 528199.0, 533109.0, 535243.0, 55069.44930550643, 73974.63012684902, 93394.0, 96283.0, 97730.5113474428, 979.4270351844109, 1006.5621454667097, 1008.4705529596873, 1047.7223535763028, 1048.6958781953301, 17744.0, 17777.46667599974, 17997.820021800137, 18045.548861278574, 18216.544586385447, 40240.59759402485, 40558.0, 40894.0, 40994.79502602468, 41101.0, 56672.43327566671, 57035.42964570467, 57258.713706431205, 57442.0, 58689.70655146697, 8392.622331994953, 8597.613107410056, 8608.182222688834, 8654.48073115615, 8792.736217913218, 6244.843878903063, 8896.599653015759, 13254.204747715168, 13377.0, 13431.261280629658, 11311.208215424842, 11733.530658773554, 11773.941130294636, 11796.174267801514, 11842.763144736884, 10859.37578077388, 11382.94308528452, 11448.82826757616, 11476.598319058792, 11734.354610496504, 8774.868376974222, 11792.587259445878, 11862.347570883685, 12225.388730563614, 12227.0, 8492.549912836766, 8736.69421570242, 8794.912050879666, 8799.912000880166, 8823.205911467741, 10732.0, 11460.65618031427, 11538.134639901873, 11538.826917596074, 11740.941295293811], "value": 9154.534667302838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.6213446638344, 1562.16424213046, 1702.582867197536, 1775.7869055713315, 1813.4559632110363, 7681.3086822186, 8600.655973761042, 8675.0, 9246.676366327172, 9269.351145419823, 8652.870206946885, 8881.200691937724, 8900.198982091626, 8900.821983560325, 8912.598933048012, 2355.399373159846, 2424.6726691896633, 2428.878556072198, 2430.6597076409316, 2436.6223235398543, 2369.0286982337243, 2375.9762402375927, 2426.648136020276, 2428.2836563213896, 2432.1609044879488, 2352.8588284702973, 2358.0685629176464, 2394.078279862248, 2422.903083876643, 2423.442608200115, 2383.95232095358, 2388.581998150317, 2404.7955923746504, 2419.2742177346813, 2420.7942324902406, 2370.099362242354, 2377.3937645900187, 2385.105585405473, 2400.0, 2403.8437501562516, 8883.244924181452, 8980.8652870207, 8997.145271199226, 9011.504367259799, 9024.684136055206, 5260.421353651095, 5457.672539647634, 5547.25112109864, 5559.11054231321, 5559.360673522516, 3391.593008838955, 3434.4676575130893, 3499.3701133795907, 3530.135116896351, 3536.4341705327024, 1115.8939900709502, 1119.7144728094365, 1134.7446824464512, 1190.196617283339, 1199.1126566340931, 12394.876051239462, 12483.126181167321, 12510.18683785551, 12524.37378131099, 12533.93733031329, 4570.063137056895, 4588.220002599566, 4686.625069994392, 4702.224133018082, 4762.333273341735, 10492.790144197073, 10522.526486308134, 10542.051215390498, 10552.41961692099, 10587.89412105869, 5274.92087618686, 5292.206169074592, 5306.681599104066, 5318.149096144598, 5323.600729945192, 4359.193549193409, 4753.287006948985, 4913.263010548446, 5029.446760856303, 5070.264811602297, 4027.2750904836826, 4076.001379662002, 4093.7953102344763, 4150.875473735793, 4224.0, 1264.7533730922567, 1281.4233594882153, 1290.0324756432676, 1304.6086174147908, 1333.953311634088, 964.2912459342377, 977.1596427072711, 988.6292640259902, 993.6571882700457, 995.6664517386612, 5925.940740592625, 5926.318473375531, 5961.4038596140035, 6047.334793172836, 6089.543284253698, 466.34711404034624, 470.76226505614443, 474.1986043586328, 1002.5989604158395, 1046.984295235572, 4187.246295666749, 4239.660827133822, 4256.808443620044, 4257.382679511454, 4266.168097221012, 10351.06840384369, 10573.2598718089, 10685.732856678489, 10732.839007414896, 10747.086497647788, 10424.061834434937, 10453.425061621532, 10457.058864702061, 10493.317934334244, 10498.737531561772, 7406.925930740731, 7659.8127290268985, 8307.792305192297, 8488.957555212308, 8535.146485351415, 5961.612495187799, 6023.0, 6029.517638588814, 6049.637021778707, 6114.969425152845, 10048.296619236875, 10258.897411026093, 10260.538275777757, 10270.07569318765, 10307.639232626821, 10066.245031622511, 10213.489325533843, 10238.12975897057, 10323.0, 10388.324758890649, 6890.896636550356, 7476.850462990818, 7556.886646700414, 7693.038370203724, 7770.689172433039, 8760.518171500375, 8820.162084601952, 8823.426477278956, 8834.602442889956, 8868.467891926504, 7380.298871607189, 7483.850322993619, 7507.061617297838, 7633.847323053619, 7730.149683534694, 7712.845743084995, 7775.339096176888, 7785.299323060952, 7808.804779880548, 8047.637856296597, 7404.888926665996, 7472.663730132266, 7489.588072656056, 7500.474966752275, 7503.212162722835, 5083.135866902561, 5184.351956005499, 5224.164133738584, 5295.735213239245, 5324.520793128482, 5071.264666623245, 5124.1032819257225, 5140.100482415637, 5240.737963101906, 5302.734863256745], "value": 4676.824313221527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5244899793296, 334.40142145559435, 337.5510570940649, 345.5922012025812, 346.2054584728049, 5582.162675598663, 5613.719314034297, 5660.462256085676, 5715.371309155989, 5758.683272420026, 5504.2018907258525, 5534.280543529346, 5555.611107222496, 5555.999840057576, 5572.275604171452, 4146.564610715869, 4222.746635201897, 4352.238358287287, 4355.586219309161, 4372.032585336596, 4309.784510774464, 4314.360542993673, 4329.242382583051, 4343.283358245885, 4366.0, 4342.196693611676, 4345.435093437849, 4359.910022494377, 4365.253898440633, 4369.803358848843, 4256.34026725858, 4336.067745434715, 4336.262835318003, 4350.956490435086, 4356.257497001193, 3838.2707285615643, 3841.1741475582603, 3844.6539811417106, 3848.749831260987, 3871.341871881759, 5377.7580008899695, 5395.0, 5406.83779486616, 5410.783568657288, 5424.647397919122, 4823.807047718087, 4978.427480839714, 4979.0, 4997.800087996512, 5030.748462576893, 5771.913421298684, 5773.884522309572, 5813.709314534256, 5815.400764789674, 5827.6887700267525, 4222.19778242133, 4234.830606775725, 4262.808173632194, 4292.356146578007, 4293.0340673348555, 5738.626989245686, 5915.674637894871, 6046.395360463963, 6049.5462840287155, 6090.299615544225, 4157.711109556048, 4198.3702444633545, 4216.810243539048, 4225.239456897788, 4231.703780735319, 4271.124419493996, 4274.807633656493, 4281.143771245701, 4284.500424851277, 4284.742915425085, 4767.475577686451, 4934.827281045146, 4939.481354457802, 4966.801327946841, 4972.950270497321, 5835.2122463466885, 5861.095144078192, 5863.384344643836, 5865.736041878125, 5875.618084824473, 1451.0350616839683, 1463.2244910197612, 1466.3474753734486, 1476.5644134980207, 1487.293535570617, 928.7399528132133, 940.5391358234552, 941.75985123793, 945.4516380499294, 954.5084281594984, 4992.400911890524, 5035.874103147451, 5057.443681195065, 5069.721165335942, 5072.898542029213, 5313.8937221255355, 5372.8656783579945, 5391.35303763543, 5461.726913654302, 5473.808416705396, 5132.79468821243, 5152.604039121827, 5283.762230699628, 5770.913436298459, 5790.826275211751, 3221.7261532769976, 3248.6101667799544, 3254.6419893811662, 3284.507323901386, 3287.309664970383, 6169.5064394848305, 6210.658413787285, 6261.0, 6290.766777793909, 6296.866564018429, 6150.753969841246, 6188.350223226586, 6225.3774622537385, 6229.501639868799, 6253.468455181361, 6256.186695729526, 6261.217347831521, 6285.051633993477, 6308.779192728324, 6315.010771606929, 5848.561357898089, 6089.695515224133, 6108.541859360655, 6166.105914642441, 6188.1027251049245, 5936.406359364029, 6008.158857760004, 6032.155498230163, 6054.243219597551, 6079.513638908788, 5881.676622759845, 6243.500519958483, 6245.3754624539, 6248.218972628421, 6254.21822272216, 4220.810063547209, 4266.146770645822, 4278.358246263086, 4293.549177336459, 4310.396544483712, 5880.8235752927485, 5935.109733540004, 6139.877202456015, 6155.72299246526, 6159.628543010884, 5917.822465326047, 5918.816236752753, 5954.880902382015, 5958.1360702697, 5970.432808883149, 5842.824715258549, 5873.500752436091, 5882.617629854046, 5902.6458412495385, 5974.37269086757, 5580.693061881636, 5780.393058728773, 5790.334111577054, 5794.333651629948, 5810.767569297181, 5926.970365148147, 5939.613925094855, 5957.0, 5976.970115149396, 6005.849853753691, 5669.6314739541795, 5785.161151633074, 5810.564207684525, 5827.213326201078, 5861.472467477777], "value": 4435.962109261545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8250102476434, 764.3846703403759, 771.6527562596833, 811.9837603247937, 863.8358711844753, 15018.774718379233, 16202.108884011375, 16220.837791622094, 16291.755623665626, 16295.918520407411, 14428.062175958556, 14435.133891966489, 14474.42102315906, 14591.197484138394, 14597.78103328451, 663.8174502011962, 803.036356372354, 814.2468216899374, 816.8652172391548, 817.1297568089965, 780.0561320801837, 802.4102284820652, 805.5972013993004, 809.8785182222684, 810.8378324335127, 846.7713717296326, 853.4495250563383, 859.5358506406533, 860.3031544448985, 861.5261606116642, 845.6110189312924, 851.0128251228607, 852.2627926843298, 855.2345650642671, 855.3883972959333, 617.4288782875867, 620.6710443464971, 621.6518749500249, 623.5977794322637, 624.3662682377391, 14140.080894741808, 14145.0, 14162.716745665131, 14169.433222671081, 14173.85826141746, 15123.697526049418, 15171.468998584996, 15336.616584585363, 15383.230838458145, 15448.227588620524, 12430.440630171574, 12565.18326308787, 12603.74792504154, 12650.177738446971, 12770.361481925867, 3903.6291552302487, 3918.725689201757, 3992.401139829049, 4049.2306461772464, 4137.2552940470705, 75764.0, 76089.61955190188, 76276.61861690712, 79440.0, 79801.0, 11853.76292474163, 11873.228240164362, 11926.986206172573, 12045.578404755966, 12191.573294934813, 22333.10667573279, 22472.775272247396, 22544.887275563844, 22601.09595616157, 22619.0, 8502.107278735768, 8506.276966457797, 8836.734897953073, 8846.646134154691, 9157.587908544132, 4690.15577196108, 4747.359106520645, 4785.784639691222, 4786.1863483207935, 4924.926126108111, 3391.3217356528794, 3444.7943219872845, 3467.150548115728, 3483.076984599083, 3511.6839484446523, 558.8295569851153, 565.6069032022705, 569.3879079989028, 572.2589246925241, 579.7217335678898, 771.9266669666373, 772.9729459468891, 774.3611520495614, 778.8636988526985, 810.7567729681072, 10266.691999240034, 10498.737531561772, 10547.630832920811, 10619.84070238947, 10728.498010278567, 602.0703644818346, 653.4054010850103, 732.6190381001849, 752.3417010116149, 765.5215490318551, 4745.9050818984115, 4883.731394773322, 4919.385076865392, 4927.211646136601, 4954.727489988013, 70046.0, 100150.0, 121115.0, 122106.38946805387, 123577.0, 66146.33853661401, 68196.0, 102668.48665756623, 102848.0, 105092.47453762683, 89114.55442722744, 91558.0, 91647.0, 91912.0, 92006.07993919976, 9550.95224523873, 9553.379030363005, 9567.569459374206, 9709.223262139154, 9760.707178784647, 36581.817090914374, 40672.59327406688, 52700.472995269556, 53053.0, 53686.46313536971, 72746.63626681833, 79265.0, 80178.59910700642, 81927.0, 82814.58592707239, 11119.555217791521, 11590.594329198437, 12761.234325940473, 13068.54260100892, 13523.391447385087, 14408.783868242195, 14595.416183352547, 14838.925805370904, 14866.658382005717, 15661.0, 14039.649008774863, 14236.644083897985, 14237.430502780187, 14242.28788560547, 14362.0, 13953.302334883418, 13979.650508737363, 14408.20754858493, 14450.85549144495, 14470.625290597376, 11469.155601597713, 11592.942035289769, 11881.524739010343, 11934.403279836148, 11961.0, 10320.015148645945, 11071.944640276746, 11114.49984750672, 11114.555417783198, 11531.358462353386, 11923.0, 12082.75834483323, 12141.57504487374, 12226.0, 12487.687807804878], "value": 7605.813431856095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 111.0, 112.0, 113.0, 114.0, 112.0, 112.0, 113.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 157.0, 178.0, 128.0, 157.0, 160.0, 129.0, 179.0, 128.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 166.0, 165.0, 170.0, 164.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 160.0, 75.0, 75.0, 75.0, 75.0, 162.0, 75.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 150.0, 85.0, 84.0, 85.0, 153.0, 83.0, 83.0, 138.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 118.0, 116.0, 118.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 150.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 60.0, 55.0, 55.0, 56.0, 54.0, 55.0, 54.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 85.0, 87.0, 80.0, 81.0, 88.0, 80.0, 103.0, 80.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 126.0, 129.0, 121.0, 125.0, 129.0, 132.0, 148.0, 132.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 163.0, 164.0, 167.0, 166.0, 168.0, 161.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 66.0, 63.0, 64.0, 63.0, 66.0, 62.0, 66.0, 62.0], "value": 64.3, "unit": "score"}]}]} 06:00:03 INFO - Return code: 0 06:00:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:03 ERROR - # TBPL SUCCESS # 06:00:03 INFO - Running post-action listener: _resource_record_post_action 06:00:03 INFO - ##### 06:00:03 INFO - ##### Finished run-tests step (success) 06:00:03 INFO - ##### 06:00:03 INFO - Running post-run listener: _resource_record_post_run 06:00:03 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 4096; Write bytes: 542007296; Read time: 4; Write time: 1486968 06:00:03 INFO - TinderboxPrint: CPU usage
13.6% 06:00:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:00:03 INFO - TinderboxPrint: I/O write bytes / time
542,007,296 / 1,486,968 06:00:03 INFO - TinderboxPrint: CPU idle
8,234.2 (86.4%) 06:00:03 INFO - TinderboxPrint: CPU user
1,225.0 (12.9%) 06:00:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:00:03 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 249438208; Read time: 0; Write time: 1064604 06:00:03 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292569088; Read time: 4; Write time: 422364 06:00:03 INFO - Running post-run listener: _upload_blobber_files 06:00:03 INFO - Blob upload gear active. 06:00:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:03 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:00:03 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:00:03 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:00:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:07 INFO - (blobuploader) - INFO - Done attempting. 06:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:08 INFO - (blobuploader) - INFO - Done attempting. 06:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:09 INFO - (blobuploader) - INFO - Done attempting. 06:00:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:09 INFO - Return code: 0 06:00:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1432a1f97875f0c8a4d8ca5365d35c548c206e436f4e0420d16365b71aa3e7f17d6eab6b33f8d3adfefe322c6fab275866218f2c968c1ee3d4ef5d7494a76c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd56d31e2e378d5f903dda77834a72b2b0ebaab55ea8c3f6025f98b8f0c8f154405f76af74dae2a50bbb7d67e756822d5297cab3623a1c7bc2dc4e0139b6ca43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88c4d79e076456274ee75913571b0cd7c9952268eff80ce5dbc40d2d656a3813be9ac5a179883c9c8b02ce182589bc77bfcf38d56cdf716d2799b16efa066cc5"} 06:00:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:09 INFO - Contents: 06:00:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1432a1f97875f0c8a4d8ca5365d35c548c206e436f4e0420d16365b71aa3e7f17d6eab6b33f8d3adfefe322c6fab275866218f2c968c1ee3d4ef5d7494a76c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd56d31e2e378d5f903dda77834a72b2b0ebaab55ea8c3f6025f98b8f0c8f154405f76af74dae2a50bbb7d67e756822d5297cab3623a1c7bc2dc4e0139b6ca43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88c4d79e076456274ee75913571b0cd7c9952268eff80ce5dbc40d2d656a3813be9ac5a179883c9c8b02ce182589bc77bfcf38d56cdf716d2799b16efa066cc5"} 06:00:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:09 INFO - Copying logs to upload dir... 06:00:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.137573 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-04 06:00:09.084548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 06:00:09.089020) ========= 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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 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/1432a1f97875f0c8a4d8ca5365d35c548c206e436f4e0420d16365b71aa3e7f17d6eab6b33f8d3adfefe322c6fab275866218f2c968c1ee3d4ef5d7494a76c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd56d31e2e378d5f903dda77834a72b2b0ebaab55ea8c3f6025f98b8f0c8f154405f76af74dae2a50bbb7d67e756822d5297cab3623a1c7bc2dc4e0139b6ca43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88c4d79e076456274ee75913571b0cd7c9952268eff80ce5dbc40d2d656a3813be9ac5a179883c9c8b02ce182589bc77bfcf38d56cdf716d2799b16efa066cc5"} build_url:https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/C3ok02QrSp6yp7VIfOmHRA/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/1432a1f97875f0c8a4d8ca5365d35c548c206e436f4e0420d16365b71aa3e7f17d6eab6b33f8d3adfefe322c6fab275866218f2c968c1ee3d4ef5d7494a76c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd56d31e2e378d5f903dda77834a72b2b0ebaab55ea8c3f6025f98b8f0c8f154405f76af74dae2a50bbb7d67e756822d5297cab3623a1c7bc2dc4e0139b6ca43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88c4d79e076456274ee75913571b0cd7c9952268eff80ce5dbc40d2d656a3813be9ac5a179883c9c8b02ce182589bc77bfcf38d56cdf716d2799b16efa066cc5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 06:00:09.114399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:00:09.114757) ========= 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=df17445c3590ff7897617a0e00000225-1465040080.48626-560449468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 06:00:09.198365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 06:00:09.201721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 06:00:09.202027) ========= ========= Total master_lag: 0.19 =========