builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466237185.7 results: success (0) buildid: 20160617223005 builduid: b1c8221182d34524bf9da20e203e607f revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.698260) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.698748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.699095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.760926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.761240) ========= 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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 01:06:26-- 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% 81.6M=0s 2016-06-18 01:06:26 (81.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.890643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.891352) ========= 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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021522 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.950903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:25.951271) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 01:06:26,882 truncating revision to first 12 chars 2016-06-18 01:06:26,882 Setting DEBUG logging. 2016-06-18 01:06:26,882 attempt 1/10 2016-06-18 01:06:26,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 01:06:27,303 unpacking tar archive at: mozilla-central-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.770849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:26.736820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:26.737163) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:26.737643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:26.737961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 01:06:26.747616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-18 01:06:26.747945) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:06:27 INFO - MultiFileLogger online at 20160618 01:06:27 in /builds/slave/test 01:06:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:06:27 INFO - {'append_to_log': False, 01:06:27 INFO - 'base_work_dir': '/builds/slave/test', 01:06:27 INFO - 'blob_upload_branch': 'Firefox', 01:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:06:27 INFO - 'branch': 'Firefox', 01:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:06:27 INFO - 'config_files': ('talos/linux_config.py',), 01:06:27 INFO - 'default_actions': ('clobber', 01:06:27 INFO - 'read-buildbot-config', 01:06:27 INFO - 'download-and-extract', 01:06:27 INFO - 'populate-webroot', 01:06:27 INFO - 'create-virtualenv', 01:06:27 INFO - 'install', 01:06:27 INFO - 'run-tests'), 01:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:06:27 INFO - 'download_minidump_stackwalk': True, 01:06:27 INFO - 'download_symbols': 'ondemand', 01:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 01:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 01:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:06:27 INFO - 'installer_path': 'installer.exe', 01:06:27 INFO - 'log_level': 'info', 01:06:27 INFO - 'log_name': 'talos', 01:06:27 INFO - 'log_to_console': True, 01:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:06:27 INFO - 'opt_config_files': (), 01:06:27 INFO - 'pip_index': False, 01:06:27 INFO - 'sps_profile': False, 01:06:27 INFO - 'sps_profile_interval': 0, 01:06:27 INFO - 'suite': 'dromaeojs', 01:06:27 INFO - 'system_bits': '32', 01:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:06:27 INFO - 'title': 'talos-linux64-ix-017', 01:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:06:27 INFO - 'use_talos_json': True, 01:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:06:27 INFO - 'work_dir': 'build'} 01:06:27 INFO - ##### 01:06:27 INFO - ##### Running clobber step. 01:06:27 INFO - ##### 01:06:27 INFO - Running pre-action listener: _resource_record_pre_action 01:06:27 INFO - Running main action method: clobber 01:06:27 INFO - rmtree: /builds/slave/test/build 01:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:06:28 INFO - Running post-action listener: _resource_record_post_action 01:06:28 INFO - ##### 01:06:28 INFO - ##### Finished clobber step (success) 01:06:28 INFO - ##### 01:06:28 INFO - ##### 01:06:28 INFO - ##### Running read-buildbot-config step. 01:06:28 INFO - ##### 01:06:28 INFO - Running pre-action listener: _resource_record_pre_action 01:06:28 INFO - Running main action method: read_buildbot_config 01:06:28 INFO - Using buildbot properties: 01:06:28 INFO - { 01:06:28 INFO - "project": "", 01:06:28 INFO - "product": "firefox", 01:06:28 INFO - "script_repo_revision": "production", 01:06:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:06:28 INFO - "repository": "", 01:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:06:28 INFO - "buildid": "20160617223005", 01:06:28 INFO - "pgo_build": "True", 01:06:28 INFO - "basedir": "/builds/slave/test", 01:06:28 INFO - "buildnumber": 347, 01:06:28 INFO - "slavename": "talos-linux64-ix-017", 01:06:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:06:28 INFO - "platform": "ubuntu64_hw", 01:06:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:06:28 INFO - "branch": "mozilla-central", 01:06:28 INFO - "repo_path": "mozilla-central", 01:06:28 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 01:06:28 INFO - "stage_platform": "linux64-pgo", 01:06:28 INFO - "builduid": "b1c8221182d34524bf9da20e203e607f", 01:06:28 INFO - "slavebuilddir": "test" 01:06:28 INFO - } 01:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:06:28 INFO - Running post-action listener: _resource_record_post_action 01:06:28 INFO - ##### 01:06:28 INFO - ##### Finished read-buildbot-config step (success) 01:06:28 INFO - ##### 01:06:28 INFO - ##### 01:06:28 INFO - ##### Running download-and-extract step. 01:06:28 INFO - ##### 01:06:28 INFO - Running pre-action listener: _resource_record_pre_action 01:06:28 INFO - Running main action method: download_and_extract 01:06:28 INFO - mkdir: /builds/slave/test/build/tests 01:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:28 INFO - https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:06:30 INFO - Downloaded 1361 bytes. 01:06:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:30 INFO - Using the following test package requirements: 01:06:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:06:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:06:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'jsshell-linux-x86_64.zip'], 01:06:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:06:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:06:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:06:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:06:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:06:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:06: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')]} 01:06:30 INFO - https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:32 INFO - Downloaded 24220449 bytes. 01:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:33 INFO - Return code: 0 01:06:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:33 INFO - https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:39 INFO - Downloaded 24220449 bytes. 01:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:41 INFO - Return code: 0 01:06: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')]} 01:06:41 INFO - https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:06:42 INFO - Downloaded 14405384 bytes. 01:06:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:06:42 INFO - Return code: 0 01:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:42 INFO - https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:06:43 INFO - Downloaded 60116221 bytes. 01:06:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:43 INFO - mkdir: /builds/slave/test/properties 01:06:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:06:43 INFO - Writing to file /builds/slave/test/properties/build_url 01:06:43 INFO - Contents: 01:06:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:44 INFO - Running post-action listener: _resource_record_post_action 01:06:44 INFO - Running post-action listener: set_extra_try_arguments 01:06:44 INFO - ##### 01:06:44 INFO - ##### Finished download-and-extract step (success) 01:06:44 INFO - ##### 01:06:44 INFO - ##### 01:06:44 INFO - ##### Running populate-webroot step. 01:06:44 INFO - ##### 01:06:44 INFO - Running pre-action listener: _resource_record_pre_action 01:06:44 INFO - Running main action method: populate_webroot 01:06:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:06:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:06:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:06:44 INFO - '--tppagecycles', 01:06:44 INFO - '7'], 01:06:44 INFO - 'tests': ['tsvgm']}}, 01:06:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:06:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:06:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:06:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:06:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['damp', 'tps']}, 01:06:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'tests': ['damp', 'tps']}, 01:06:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['dromaeo_dom']}, 01:06:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:06:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['basic_compositor_video']}, 01:06:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:06:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'other-e10s': {'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['a11yr', 01:06:44 INFO - 'ts_paint', 01:06:44 INFO - 'tpaint', 01:06:44 INFO - 'sessionrestore', 01:06:44 INFO - 'sessionrestore_no_auto_restore', 01:06:44 INFO - 'tabpaint']}, 01:06:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['tsvgx', 01:06:44 INFO - 'tsvgr_opacity', 01:06:44 INFO - 'tart', 01:06:44 INFO - 'tscrollx', 01:06:44 INFO - 'cart']}, 01:06:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:06:44 INFO - 'tsvgr_opacity', 01:06:44 INFO - 'tart', 01:06:44 INFO - 'tscrollx', 01:06:44 INFO - 'cart']}, 01:06:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'talos_options': ['--disable-e10s'], 01:06:44 INFO - 'tests': ['tp5o']}, 01:06:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'tests': ['tp5o']}, 01:06:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'talos_options': ['--disable-e10s', 01:06:44 INFO - '--xperf_path', 01:06:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:44 INFO - 'tests': ['tp5n']}, 01:06:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:44 INFO - 'talos_options': ['--xperf_path', 01:06:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:44 INFO - 'tests': ['tp5n']}}, 01:06:44 INFO - 'talos.zip': {'path': '', 01:06:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:06:44 INFO - Running post-action listener: _resource_record_post_action 01:06:44 INFO - ##### 01:06:44 INFO - ##### Finished populate-webroot step (success) 01:06:44 INFO - ##### 01:06:44 INFO - ##### 01:06:44 INFO - ##### Running create-virtualenv step. 01:06:44 INFO - ##### 01:06:44 INFO - Running pre-action listener: _resource_record_pre_action 01:06:44 INFO - Running main action method: create_virtualenv 01:06:44 INFO - Creating virtualenv /builds/slave/test/build/venv 01:06:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:06:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:06:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:06:44 INFO - Using real prefix '/usr' 01:06:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:06:45 INFO - Installing distribute.............................................................................................................................................................................................done. 01:06:47 INFO - Installing pip.................done. 01:06:47 INFO - Return code: 0 01:06:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:06:47 INFO - Using env: {'DISPLAY': ':0', 01:06:47 INFO - 'HOME': '/home/cltbld', 01:06:47 INFO - 'LANG': 'en_US.UTF-8', 01:06:47 INFO - 'LANGUAGE': 'en_US:en', 01:06:47 INFO - 'LOGNAME': 'cltbld', 01:06:47 INFO - 'MAIL': '/var/mail/cltbld', 01:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:47 INFO - 'MOZ_NO_REMOTE': '1', 01:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:47 INFO - 'NO_EM_RESTART': '1', 01:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:47 INFO - 'PWD': '/builds/slave/test', 01:06:47 INFO - 'SHELL': '/bin/bash', 01:06:47 INFO - 'SHLVL': '1', 01:06:47 INFO - 'TERM': 'linux', 01:06:47 INFO - 'TMOUT': '86400', 01:06:47 INFO - 'USER': 'cltbld', 01:06:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:47 INFO - '_': '/tools/buildbot/bin/python'} 01:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:06:47 INFO - Cleaning up... 01:06:47 INFO - Return code: 0 01:06:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:06:47 INFO - Using env: {'DISPLAY': ':0', 01:06:47 INFO - 'HOME': '/home/cltbld', 01:06:47 INFO - 'LANG': 'en_US.UTF-8', 01:06:47 INFO - 'LANGUAGE': 'en_US:en', 01:06:47 INFO - 'LOGNAME': 'cltbld', 01:06:47 INFO - 'MAIL': '/var/mail/cltbld', 01:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:47 INFO - 'MOZ_NO_REMOTE': '1', 01:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:47 INFO - 'NO_EM_RESTART': '1', 01:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:47 INFO - 'PWD': '/builds/slave/test', 01:06:47 INFO - 'SHELL': '/bin/bash', 01:06:47 INFO - 'SHLVL': '1', 01:06:47 INFO - 'TERM': 'linux', 01:06:47 INFO - 'TMOUT': '86400', 01:06:47 INFO - 'USER': 'cltbld', 01:06:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:47 INFO - '_': '/tools/buildbot/bin/python'} 01:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:47 INFO - Downloading/unpacking psutil>=3.1.1 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:49 INFO - Installing collected packages: psutil 01:06:49 INFO - Running setup.py install for psutil 01:06:49 INFO - building 'psutil._psutil_linux' extension 01:06:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:06: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 01:06:49 INFO - building 'psutil._psutil_posix' extension 01:06: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 01:06:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:50 INFO - Successfully installed psutil 01:06:50 INFO - Cleaning up... 01:06:50 INFO - Return code: 0 01:06:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:50 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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:50 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 01:06:50 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 01:06:50 INFO - Using env: {'DISPLAY': ':0', 01:06:50 INFO - 'HOME': '/home/cltbld', 01:06:50 INFO - 'LANG': 'en_US.UTF-8', 01:06:50 INFO - 'LANGUAGE': 'en_US:en', 01:06:50 INFO - 'LOGNAME': 'cltbld', 01:06:50 INFO - 'MAIL': '/var/mail/cltbld', 01:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:50 INFO - 'MOZ_NO_REMOTE': '1', 01:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:50 INFO - 'NO_EM_RESTART': '1', 01:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:50 INFO - 'PWD': '/builds/slave/test', 01:06:50 INFO - 'SHELL': '/bin/bash', 01:06:50 INFO - 'SHLVL': '1', 01:06:50 INFO - 'TERM': 'linux', 01:06:50 INFO - 'TMOUT': '86400', 01:06:50 INFO - 'USER': 'cltbld', 01:06:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:50 INFO - '_': '/tools/buildbot/bin/python'} 01:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:06:52 INFO - Installing collected packages: mozsystemmonitor 01:06:52 INFO - Running setup.py install for mozsystemmonitor 01:06:52 INFO - Successfully installed mozsystemmonitor 01:06:52 INFO - Cleaning up... 01:06:52 INFO - Return code: 0 01:06:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:06:52 INFO - Using env: {'DISPLAY': ':0', 01:06:52 INFO - 'HOME': '/home/cltbld', 01:06:52 INFO - 'LANG': 'en_US.UTF-8', 01:06:52 INFO - 'LANGUAGE': 'en_US:en', 01:06:52 INFO - 'LOGNAME': 'cltbld', 01:06:52 INFO - 'MAIL': '/var/mail/cltbld', 01:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:52 INFO - 'MOZ_NO_REMOTE': '1', 01:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:52 INFO - 'NO_EM_RESTART': '1', 01:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:52 INFO - 'PWD': '/builds/slave/test', 01:06:52 INFO - 'SHELL': '/bin/bash', 01:06:52 INFO - 'SHLVL': '1', 01:06:52 INFO - 'TERM': 'linux', 01:06:52 INFO - 'TMOUT': '86400', 01:06:52 INFO - 'USER': 'cltbld', 01:06:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:52 INFO - '_': '/tools/buildbot/bin/python'} 01:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:52 INFO - Downloading/unpacking jsonschema==2.5.1 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:06:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06:54 INFO - Downloading functools32-3.2.3-2.tar.gz 01:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:06:54 INFO - warning: no files found matching '*.txt' 01:06:54 INFO - no previously-included directories found matching 'build' 01:06:54 INFO - no previously-included directories found matching 'dist' 01:06:54 INFO - no previously-included directories found matching '.git*' 01:06:54 INFO - Installing collected packages: jsonschema, functools32 01:06:54 INFO - Running setup.py install for functools32 01:06:55 INFO - warning: no files found matching '*.txt' 01:06:55 INFO - no previously-included directories found matching 'build' 01:06:55 INFO - no previously-included directories found matching 'dist' 01:06:55 INFO - no previously-included directories found matching '.git*' 01:06:55 INFO - Successfully installed jsonschema functools32 01:06:55 INFO - Cleaning up... 01:06:55 INFO - Return code: 0 01:06:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:06:55 INFO - Using env: {'DISPLAY': ':0', 01:06:55 INFO - 'HOME': '/home/cltbld', 01:06:55 INFO - 'LANG': 'en_US.UTF-8', 01:06:55 INFO - 'LANGUAGE': 'en_US:en', 01:06:55 INFO - 'LOGNAME': 'cltbld', 01:06:55 INFO - 'MAIL': '/var/mail/cltbld', 01:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:55 INFO - 'MOZ_NO_REMOTE': '1', 01:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:55 INFO - 'NO_EM_RESTART': '1', 01:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:55 INFO - 'PWD': '/builds/slave/test', 01:06:55 INFO - 'SHELL': '/bin/bash', 01:06:55 INFO - 'SHLVL': '1', 01:06:55 INFO - 'TERM': 'linux', 01:06:55 INFO - 'TMOUT': '86400', 01:06:55 INFO - 'USER': 'cltbld', 01:06:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:55 INFO - '_': '/tools/buildbot/bin/python'} 01:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:55 INFO - Downloading/unpacking blobuploader==1.2.4 01:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:06:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:06:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - Downloading docopt-0.6.1.tar.gz 01:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:06:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:06:58 INFO - Running setup.py install for blobuploader 01:06:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:06:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:06:58 INFO - Running setup.py install for requests 01:06:58 INFO - Running setup.py install for docopt 01:06:58 INFO - Successfully installed blobuploader requests docopt 01:06:58 INFO - Cleaning up... 01:06:58 INFO - Return code: 0 01:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:58 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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:58 INFO - Using env: {'DISPLAY': ':0', 01:06:58 INFO - 'HOME': '/home/cltbld', 01:06:58 INFO - 'LANG': 'en_US.UTF-8', 01:06:58 INFO - 'LANGUAGE': 'en_US:en', 01:06:58 INFO - 'LOGNAME': 'cltbld', 01:06:58 INFO - 'MAIL': '/var/mail/cltbld', 01:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:58 INFO - 'MOZ_NO_REMOTE': '1', 01:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:58 INFO - 'NO_EM_RESTART': '1', 01:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:58 INFO - 'PWD': '/builds/slave/test', 01:06:58 INFO - 'SHELL': '/bin/bash', 01:06:58 INFO - 'SHLVL': '1', 01:06:58 INFO - 'TERM': 'linux', 01:06:58 INFO - 'TMOUT': '86400', 01:06:58 INFO - 'USER': 'cltbld', 01:06:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:58 INFO - '_': '/tools/buildbot/bin/python'} 01:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:58 INFO - Running setup.py (path:/tmp/pip-3g6oEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:58 INFO - Running setup.py (path:/tmp/pip-hCyNZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:58 INFO - Running setup.py (path:/tmp/pip-waY57d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:59 INFO - Running setup.py (path:/tmp/pip-RGXGRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:59 INFO - Running setup.py (path:/tmp/pip-wSH1id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:59 INFO - Running setup.py (path:/tmp/pip-6QX7q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:59 INFO - Running setup.py (path:/tmp/pip-9eIf9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:59 INFO - Running setup.py (path:/tmp/pip-_1DvMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:59 INFO - Running setup.py (path:/tmp/pip-dXt8pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:59 INFO - Running setup.py (path:/tmp/pip-DLo2QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:59 INFO - Running setup.py (path:/tmp/pip-fIkAEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:59 INFO - Running setup.py (path:/tmp/pip-1xQHal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:59 INFO - Running setup.py (path:/tmp/pip-_DOhp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:59 INFO - Running setup.py (path:/tmp/pip-oGFtdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:59 INFO - Running setup.py (path:/tmp/pip-ouh4vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:59 INFO - Running setup.py (path:/tmp/pip-HI5z3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:59 INFO - Running setup.py (path:/tmp/pip-W61zJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:07:00 INFO - Running setup.py install for manifestparser 01:07:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Running setup.py install for mozcrash 01:07:00 INFO - Running setup.py install for mozdebug 01:07:00 INFO - Running setup.py install for mozdevice 01:07:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Running setup.py install for mozfile 01:07:00 INFO - Running setup.py install for mozhttpd 01:07:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Running setup.py install for mozinfo 01:07:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Running setup.py install for mozInstall 01:07:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:07:00 INFO - Running setup.py install for mozleak 01:07:00 INFO - Running setup.py install for mozlog 01:07:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Running setup.py install for moznetwork 01:07:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Running setup.py install for mozprocess 01:07:01 INFO - Running setup.py install for mozprofile 01:07:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Running setup.py install for mozrunner 01:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Running setup.py install for mozscreenshot 01:07:01 INFO - Running setup.py install for moztest 01:07:01 INFO - Running setup.py install for mozversion 01:07:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:07:01 INFO - Cleaning up... 01:07:01 INFO - Return code: 0 01:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:01 INFO - Using env: {'DISPLAY': ':0', 01:07:01 INFO - 'HOME': '/home/cltbld', 01:07:01 INFO - 'LANG': 'en_US.UTF-8', 01:07:01 INFO - 'LANGUAGE': 'en_US:en', 01:07:01 INFO - 'LOGNAME': 'cltbld', 01:07:01 INFO - 'MAIL': '/var/mail/cltbld', 01:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:01 INFO - 'MOZ_NO_REMOTE': '1', 01:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:01 INFO - 'NO_EM_RESTART': '1', 01:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:01 INFO - 'PWD': '/builds/slave/test', 01:07:01 INFO - 'SHELL': '/bin/bash', 01:07:01 INFO - 'SHLVL': '1', 01:07:01 INFO - 'TERM': 'linux', 01:07:01 INFO - 'TMOUT': '86400', 01:07:01 INFO - 'USER': 'cltbld', 01:07:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:01 INFO - '_': '/tools/buildbot/bin/python'} 01:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:02 INFO - Running setup.py (path:/tmp/pip-aWjIld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:02 INFO - Running setup.py (path:/tmp/pip-ZD0y8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:02 INFO - Running setup.py (path:/tmp/pip-Z9qA9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:02 INFO - Running setup.py (path:/tmp/pip-_Crn1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:02 INFO - Running setup.py (path:/tmp/pip-PmxTZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:02 INFO - Running setup.py (path:/tmp/pip-pum7f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:02 INFO - Running setup.py (path:/tmp/pip-YRVp17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:02 INFO - Running setup.py (path:/tmp/pip-tgXGTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:02 INFO - Running setup.py (path:/tmp/pip-UmRLIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:02 INFO - Running setup.py (path:/tmp/pip-TKERUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:02 INFO - Running setup.py (path:/tmp/pip-d_sUAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:02 INFO - Running setup.py (path:/tmp/pip-V_XAwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:02 INFO - Running setup.py (path:/tmp/pip-ch6Wfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:03 INFO - Running setup.py (path:/tmp/pip-tDe65L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:03 INFO - Running setup.py (path:/tmp/pip-vwSQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:03 INFO - Running setup.py (path:/tmp/pip-bz6EXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:03 INFO - Running setup.py (path:/tmp/pip-QefrMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:05 INFO - Downloading blessings-1.6.tar.gz 01:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:07:05 INFO - Installing collected packages: blessings 01:07:05 INFO - Running setup.py install for blessings 01:07:05 INFO - Successfully installed blessings 01:07:05 INFO - Cleaning up... 01:07:05 INFO - Return code: 0 01:07:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:05 INFO - Reading from file tmpfile_stdout 01:07:05 INFO - Current package versions: 01:07:05 INFO - argparse == 1.2.1 01:07:05 INFO - blessings == 1.6 01:07:05 INFO - blobuploader == 1.2.4 01:07:05 INFO - docopt == 0.6.1 01:07:05 INFO - functools32 == 3.2.3-2 01:07:05 INFO - jsonschema == 2.5.1 01:07:05 INFO - manifestparser == 1.1 01:07:05 INFO - mozInstall == 1.12 01:07:05 INFO - mozcrash == 0.17 01:07:05 INFO - mozdebug == 0.1 01:07:05 INFO - mozdevice == 0.48 01:07:05 INFO - mozfile == 1.2 01:07:05 INFO - mozhttpd == 0.7 01:07:05 INFO - mozinfo == 0.9 01:07:05 INFO - mozleak == 0.1 01:07:05 INFO - mozlog == 3.2 01:07:05 INFO - moznetwork == 0.27 01:07:05 INFO - mozprocess == 0.22 01:07:05 INFO - mozprofile == 0.28 01:07:05 INFO - mozrunner == 6.11 01:07:05 INFO - mozscreenshot == 0.1 01:07:05 INFO - mozsystemmonitor == 0.3 01:07:05 INFO - moztest == 0.7 01:07:05 INFO - mozversion == 1.4 01:07:05 INFO - psutil == 3.1.1 01:07:05 INFO - requests == 1.2.3 01:07:05 INFO - wsgiref == 0.1.2 01:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:05 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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:05 INFO - Using env: {'DISPLAY': ':0', 01:07:05 INFO - 'HOME': '/home/cltbld', 01:07:05 INFO - 'LANG': 'en_US.UTF-8', 01:07:05 INFO - 'LANGUAGE': 'en_US:en', 01:07:05 INFO - 'LOGNAME': 'cltbld', 01:07:05 INFO - 'MAIL': '/var/mail/cltbld', 01:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:05 INFO - 'MOZ_NO_REMOTE': '1', 01:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:05 INFO - 'NO_EM_RESTART': '1', 01:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:05 INFO - 'PWD': '/builds/slave/test', 01:07:05 INFO - 'SHELL': '/bin/bash', 01:07:05 INFO - 'SHLVL': '1', 01:07:05 INFO - 'TERM': 'linux', 01:07:05 INFO - 'TMOUT': '86400', 01:07:05 INFO - 'USER': 'cltbld', 01:07:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:05 INFO - '_': '/tools/buildbot/bin/python'} 01:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:07:05 INFO - Cleaning up... 01:07:05 INFO - Return code: 0 01:07:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:07: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', 'jsonschema'] in /builds/slave/test/build 01:07: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 jsonschema 01:07:05 INFO - Using env: {'DISPLAY': ':0', 01:07:05 INFO - 'HOME': '/home/cltbld', 01:07:05 INFO - 'LANG': 'en_US.UTF-8', 01:07:05 INFO - 'LANGUAGE': 'en_US:en', 01:07:05 INFO - 'LOGNAME': 'cltbld', 01:07:05 INFO - 'MAIL': '/var/mail/cltbld', 01:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:05 INFO - 'MOZ_NO_REMOTE': '1', 01:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:05 INFO - 'NO_EM_RESTART': '1', 01:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:05 INFO - 'PWD': '/builds/slave/test', 01:07:05 INFO - 'SHELL': '/bin/bash', 01:07:05 INFO - 'SHLVL': '1', 01:07:05 INFO - 'TERM': 'linux', 01:07:05 INFO - 'TMOUT': '86400', 01:07:05 INFO - 'USER': 'cltbld', 01:07:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:05 INFO - '_': '/tools/buildbot/bin/python'} 01:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:07:06 INFO - Cleaning up... 01:07:06 INFO - Return code: 0 01:07:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:06 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 0x7f95e7e72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe56190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, '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': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:07:06 INFO - Using env: {'DISPLAY': ':0', 01:07:06 INFO - 'HOME': '/home/cltbld', 01:07:06 INFO - 'LANG': 'en_US.UTF-8', 01:07:06 INFO - 'LANGUAGE': 'en_US:en', 01:07:06 INFO - 'LOGNAME': 'cltbld', 01:07:06 INFO - 'MAIL': '/var/mail/cltbld', 01:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:06 INFO - 'MOZ_NO_REMOTE': '1', 01:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:06 INFO - 'NO_EM_RESTART': '1', 01:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:06 INFO - 'PWD': '/builds/slave/test', 01:07:06 INFO - 'SHELL': '/bin/bash', 01:07:06 INFO - 'SHLVL': '1', 01:07:06 INFO - 'TERM': 'linux', 01:07:06 INFO - 'TMOUT': '86400', 01:07:06 INFO - 'USER': 'cltbld', 01:07:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:06 INFO - '_': '/tools/buildbot/bin/python'} 01:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:06 INFO - Downloading/unpacking flake8 01:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:07:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:07:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:08 INFO - no previously-included directories found matching 'docs/_build' 01:07:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:07:09 INFO - Running setup.py install for pep8 01:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:09 INFO - no previously-included directories found matching 'docs/_build' 01:07:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:07:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:07:09 INFO - Cleaning up... 01:07:09 INFO - Return code: 0 01:07:09 INFO - Running post-action listener: _resource_record_post_action 01:07:09 INFO - Running post-action listener: _start_resource_monitoring 01:07:09 INFO - Starting resource monitoring. 01:07:09 INFO - ##### 01:07:09 INFO - ##### Finished create-virtualenv step (success) 01:07:09 INFO - ##### 01:07:09 INFO - ##### 01:07:09 INFO - ##### Running install step. 01:07:09 INFO - ##### 01:07:09 INFO - Running pre-action listener: _resource_record_pre_action 01:07:09 INFO - Running main action method: install 01:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:09 INFO - Reading from file tmpfile_stdout 01:07:09 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:09 INFO - Reading from file tmpfile_stdout 01:07:09 INFO - Output received: 01:07:09 INFO - Usage: mozinstall [options] installer 01:07:09 INFO - Options: 01:07:09 INFO - -h, --help show this help message and exit 01:07:09 INFO - -d DEST, --destination=DEST 01:07:09 INFO - Directory to install application into. [default: 01:07:09 INFO - "/builds/slave/test"] 01:07:09 INFO - --app=APP Application being installed. [default: firefox] 01:07:09 INFO - mkdir: /builds/slave/test/build/application 01:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:07:26 INFO - Reading from file tmpfile_stdout 01:07:26 INFO - Output received: 01:07:26 INFO - /builds/slave/test/build/application/firefox/firefox 01:07:26 INFO - Running post-action listener: _resource_record_post_action 01:07:26 INFO - ##### 01:07:26 INFO - ##### Finished install step (success) 01:07:26 INFO - ##### 01:07:26 INFO - ##### 01:07:26 INFO - ##### Running run-tests step. 01:07:26 INFO - ##### 01:07:26 INFO - Running pre-action listener: _resource_record_pre_action 01:07:26 INFO - Running main action method: run_tests 01:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:07:26 INFO - Python 2.7.3 01:07:26 INFO - Return code: 0 01:07:26 INFO - grabbing minidump binary from tooltool 01:07: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')]} 01:07: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 0xee8110>, '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 0xe54230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe546c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:07: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 01:07: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 01:07: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 01:07:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:07:26 INFO - Return code: 0 01:07:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:07:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:07:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:07:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:07:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:07:27 INFO - Return code: 0 01:07: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:07: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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:07:27 INFO - Using env: {'DISPLAY': ':0', 01:07:27 INFO - 'HOME': '/home/cltbld', 01:07:27 INFO - 'LANG': 'en_US.UTF-8', 01:07:27 INFO - 'LANGUAGE': 'en_US:en', 01:07:27 INFO - 'LOGNAME': 'cltbld', 01:07:27 INFO - 'MAIL': '/var/mail/cltbld', 01:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:27 INFO - 'MOZ_NO_REMOTE': '1', 01:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:27 INFO - 'NO_EM_RESTART': '1', 01:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:27 INFO - 'PWD': '/builds/slave/test', 01:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:07:27 INFO - 'SHELL': '/bin/bash', 01:07:27 INFO - 'SHLVL': '1', 01:07:27 INFO - 'TERM': 'linux', 01:07:27 INFO - 'TMOUT': '86400', 01:07:27 INFO - 'USER': 'cltbld', 01:07:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751', 01:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:27 INFO - '_': '/tools/buildbot/bin/python'} 01:07:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:07:27 INFO - mozversion application_buildid: 20160617223005 01:07:27 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 01:07:27 INFO - mozversion application_display_name: Nightly 01:07:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:07:27 INFO - mozversion application_name: Firefox 01:07:27 INFO - mozversion application_remotingname: firefox 01:07:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:07:27 INFO - mozversion application_vendor: Mozilla 01:07:27 INFO - mozversion application_version: 50.0a1 01:07:27 INFO - mozversion platform_buildid: 20160617223005 01:07:27 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 01:07:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:07:27 INFO - mozversion platform_version: 50.0a1 01:07:27 INFO - using testdate: 1466237247 01:07:27 INFO - actual date: 1466237247 01:07:27 INFO - starting webserver on 'localhost:35947' 01:07:27 INFO - SUITE-START | Running 2 tests 01:07:27 INFO - TEST-START | dromaeo_css 01:07:27 INFO - operating with platform_type : linux_ 01:07:27 INFO - Initialising browser for dromaeo_css test... 01:07:27 INFO - TEST-INFO | started process 28565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Lb8WN/profile http://localhost:35947/getInfo.html) 01:07:31 INFO - PROCESS | 28565 | __metrics Screen width/height:1600/1200 01:07:31 INFO - PROCESS | 28565 | colorDepth:24 01:07:31 INFO - PROCESS | 28565 | Browser inner width/height: 1024/697 01:07:31 INFO - PROCESS | 28565 | __metrics 01:07:32 INFO - PROCESS | 28565 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:07:33 INFO - TEST-INFO | 28565: exit 0 01:07:33 INFO - Browser initialized. 01:07:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:07:33 INFO - TEST-INFO | started process 28645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Lb8WN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:45 INFO - PROCESS | 28645 | RSS: Main: 173768704 01:07:45 INFO - PROCESS | 28645 | 01:08:37 INFO - PROCESS | 28645 | 1466237316999 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:10:44 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35947/tests/dromaeo/cssquery-ext.html) 01:10:45 INFO - PROCESS | 28645 | RSS: Main: 247685120 01:10:45 INFO - PROCESS | 28645 | 01:13:48 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-ext.html (next: http://localhost:35947/tests/dromaeo/cssquery-jquery.html) 01:13:49 INFO - PROCESS | 28645 | RSS: Main: 262123520 01:13:49 INFO - PROCESS | 28645 | 01:16:50 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35947/tests/dromaeo/cssquery-mootools.html) 01:16:51 INFO - PROCESS | 28645 | RSS: Main: 260182016 01:16:51 INFO - PROCESS | 28645 | 01:19:53 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35947/tests/dromaeo/cssquery-prototype.html) 01:19:54 INFO - PROCESS | 28645 | RSS: Main: 261402624 01:19:54 INFO - PROCESS | 28645 | 01:22:56 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35947/tests/dromaeo/cssquery-yui.html) 01:22:57 INFO - PROCESS | 28645 | RSS: Main: 246829056 01:22:57 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | Cycle 1(1): loaded http://localhost:35947/tests/dromaeo/cssquery-yui.html (next: http://localhost:35947/tests/dromaeo/cssquery-dojo.html) 01:26:00 INFO - PROCESS | 28645 | RSS: Main: 292044800 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | __start_tp_report 01:26:00 INFO - PROCESS | 28645 | _x_x_mozilla_page_load 01:26:00 INFO - PROCESS | 28645 | _x_x_mozilla_page_load_details 01:26:00 INFO - PROCESS | 28645 | |i|pagename|runs| 01:26:00 INFO - PROCESS | 28645 | |0;dojo.html;3075.138961090894;3075.8308293043883;3090.119315994941;3116.439040972624;3126.2497000719836;5190.8442746717565;5236.7905283788605;5331.546818520425;5395.595330350225;5431.402545719972;5309.283246761686;5324.307839980797;5384.40771515133;5444.50999410053;5466.890662186754;4795.736234507101;4823.8070477181045;4831.7584120794;4924.384451943507;4936.7778449969655;4934.062528119646;4980.850574482772;4993.875153121165;4998.775055122528;5048.394192696882;4791.161546729309;4819.759012049419;4922.483139270379;4924.015196960604;4954.554090131887;4883.8779030524165;4918.311436398872;4919.7540122993705;4936.185529387682;4990.65065445419;4861.513848615145;4873.31773551703;4900.313956046157;4906.656534042619;4938.703677779309;5300.151975683911;5341.278927344798;5383.811566595189;5420.159875219348;5460.34475862899;5807.30312362515;5823.67969761663;5829.941700582982;5831.096180092092;5852;5871.677057761822;5877.67672777997;5890.116482527612;5909.172715819789;5919.1417244499735;5273.077211487975;5279.577633789326;5345.3852806926925;5346.492083252085;5448.782048718046;5852.795152169653;5861.325947516005;5910.379410161957;5910.8817823643285;5923.200367950271;5700.4869561738815;5707.486326230659;5708.857278568069;5712.714364281769;5712.714364281769;5609.691466969356;5638;5678.630888992285;5738.282714660668;5782.479576838105;5714.599978001583;5752.223449834302;5756.165356023437;5760.596758226968;5766.192733017381;5530.944690553123;5764.481196692318;5769.538436925036;5769.769209231667;5776.624519406225;4325.351197320364;4341.7829108545075;4361.433013708198;4397.274449715825;4421.248387774086;3913.4325522799036;3924.3917192835156;3933;3944.9605503944595;3963.0884896473394;5310.946890531045;5371.355437347465;5499.230107784913;5500.064988951888;5506.531944784738;5745.626534275259;5824.6796426196115;5848.152017957373;5850.297964244318;5900.734466948998;5460.208269800936;5497.917531237034;5500;5504.394516603171;5506;4852.611791056707;4915.139850526144;4981.178105612534;5013.724245166478;5078.492150784966;6014.669193194329;6017.969910150421;6020.217371741645;6028.668423236676;6070.0591408331775;5832.650040997553;5843.415658434123;5844.649321040752;5846.239988801429;5847.853803654943;5796.971015144897;5825.300963884361;5884.941150588439;5924.851878703067;5981.491573216325;5703.401142880104;5706.115552089433;5709.628874123168;5710.914336285042;5717.771289148387;5745.396733342939;5750.453706897838;5779.219805326227;5791.305043394819;5805.680687562224;5505.311836020497;5526.806561770319;5588.30146231721;5611.971940140274;5636.549076073822;5620.12888002344;5622.915656265078;5629.662220266797;5633.774649013993;5636.1827535008015;5394.2987411637805;5519.972400137974;5524.806631767869;5525.585581081516;5526.944730552804;5488.588355873246;5512.062949298549;5575.526080283222;5583.218349431002;5623.690697011703;5471.425500322409;5503.257060296809;5539.224508568723;5540.722963851711;5554.944450555443 01:26:00 INFO - PROCESS | 28645 | |1;ext.html;603.6709993053785;627.4478458956117;639.5555089212996;643.9985822046718;648.031193365918;30791.230219244502;42705.78647106768;43535.3469697954;43556.56443435565;43603;45106.32340514895;45572.316415253714;45576.77211613937;45596;45610.7719461403;8072.878906816373;8937.55312234389;9104.135107164842;10539.789204215911;10819.296745711543;10639.680809575726;10728.892711072867;10733.51699173539;10749.247552671317;10749.946250268738;10806.891931080707;10845.240833141683;10847.945760271226;10852.457377131152;10855.40295283759;8115.823205635179;10444.112250458682;10650;10660.307080039773;11018.889811101946;10727.034566889017;10731;10789;10800.973907478778;10809.297395669257;42410;42644.78677606592;42646.57353426457;42650.786746066384;42829;3543.929121417583;3702.685271751904;3732.029672285198;3866.033491627093;3895.18201177753;32011.51982720261;32288;33156.83421582901;33359.83320083384;33397.3320533588;4441.111777644484;4491.702176494658;4492.415985921842;4566.54334566544;4665.930011049837;335348;336370;336604;336856;337312;33572.66427335695;59227.407725923054;59894.70052649796;60021;60055;35147.4727879082;36537.634623653954;36551.817240913624;36561.45157822635;36569.26861462756;12541.122121451594;13263.73472530544;13392.464301428028;13407.530736424178;13480.460781568823;10786.137109031259;11001.779964400666;11005.229633925548;11081.113510919107;11097.778044439228;8274.420790544724;8312.584370781558;8322.417430779908;8378.706745264008;8421.789455263544;3215.324781795802;3261.8532166052582;3280.819554924502;3283.885064022748;3302.8348582570775;1061.2093989977361;1069.337011053152;1114.4483480676954;1129.3393364881636;1148.9597864074885;32007.359852802812;32526;32567.674323256466;32666.346673066404;33265.334693305995;1081.297156848055;1092.186321190718;1133.5975728616388;1148.724306166514;1231.07054174098;16695;17077.31690732357;17320.826791732172;17616;17797.911010445125;570675;580611;580909;583216;583566;59619.10571341347;60216.09675854866;60399;60409.39590604125;60431.395686042575;1243.8445194350707;1316.7103237287781;1321.4185758266333;1352.1278775190144;1359.157322460081;32520.186995325304;33474.16314592155;33514.49728254127;33708.83145584256;33922.83038584791;49160.508394915596;49700.50299497104;49849;49862;49907.25139122989;388901;392589;394391;394535;394658;25405.491890161724;27283.590746138427;28131.71868281291;28429.431411372072;29756;47483.76258118687;48356.75821620869;48579;49587.752061240906;49683.254751179484;40255;41253.1749365005;41609.37585936153;42223.15553688847;42306;41198;41231;41250.1749964993;41674.58325416828;42262.15475690408;38262.95297993478;39445;39780.403293951196;39871;39997;33464.1633959153;36173.457398138526;36647.63352366549;37012;37041.25917481689;27677.446451071268;27983.300417489725;28046;28171;28214.43571128525 01:26:00 INFO - PROCESS | 28645 | |2;jquery.html;373.6786363727195;380.2660864531455;380.7468033757551;382.3805435194985;393.9074317535377;18022.5494362641;19456.610867782634;19801.801981980178;20413.693794593073;20434.795652043475;18859.52851178718;18944.431667049976;18993.240270389204;19198.424047278568;19564;5392.056390131731;5455.345358556969;5601.467860553262;5605.607607467479;5649.350324712669;5523.475269849358;5588.552915766729;5592.468715472024;5608.214849921014;5614.606977511576;5333.946660533384;5538.141588053858;5559.666420014792;5559.694216818073;5599.524040456566;5509.531689806371;5545.861353466155;5555.083411237141;5556.194351818984;5563.666180029211;4954.826581069681;4997.425296090923;5000.974995125038;5030.622703297231;5057.4689657585795;22150.33548993533;22241.55516889669;22416.32751017472;22439.887800560893;22576.548469030527;2475.4306509502735;2548.5157820014324;2561.731018243076;2860.356419805548;3046.4973279408873;7848.058233012075;12432.937835310857;14448.277586120757;14561.708765824624;15008.774868376982;1905.8380037696813;1959.9314024009234;1971.4578490914969;2001.0595020340418;2022.8685135466148;73580.6320968397;73816.6309168456;75289.62355188244;75492.62253688752;77052;10223.693289201336;10301.639442619473;10580.841287380696;10617.73455663599;10783.13734901206;14471.85528144726;14508.492202772852;14673.413063477556;14698.26508674562;14732.631684207767;6978.685959131852;7507.849843003219;7523.3229009389415;7544.773656790305;7554.2823431773895;7029.0862187915245;7031.929680703128;7132.358087772125;7152.427805775629;7155.284471552803;6372.6495042773095;6554.967225163844;6564.212294524687;6654.3345665434035;6734.090897728744;1873.0198328551828;1896.2130715753083;1911.9808801912081;1946.571754214099;1973.319204874316;897.7710683775596;974.741693451236;979.4417182206216;1015.6140666546665;1025.8153532364247;18422.434093102238;18957.90521047386;18973.241070357308;19146.80853191478;19656.017199139987;960.7309953213112;978.8189185000798;981.3621146254991;993.7068564773409;997.7356000659831;10279.715035620547;10806.459677016275;10846.78306433867;10956.506957186946;11004.119670426348;464199;471530;517355.89254375914;533163;537804;63938.36061639417;81257;83682.16317836744;89098.55450722705;89223.55388223147;1006.6778630838062;1007.7228762090484;1024.1857723110145;1044.6343779677052;1052.4106500359824;13602.659933501742;16697.582560436087;17033.91483042577;18015.819841801414;18212.908935455238;32041.6795832048;37188.81405592955;39553.406698898965;41421.1715765689;41442.37836432516;46258.768706156254;55259.171112432545;55884.44115558955;56155.43844561502;57678.423215768984;5621.100623900156;6315.4947604192475;7790.805229869298;8208.753737387888;8254.42219044661;12270;13154.34228288601;13408.32958352098;13419.127756695783;13580.728385432434;11311.264767790068;11504.36725980079;11668.88331116678;11684.649460516199;11846.822297665714;11122.443877805916;11417.60038398652;11698.649040528799;12076.396180191132;12091.516339346328;11702.941485292518;11838.348890811088;11854.11094167958;11901.345426001306;11966.22219555726;8054;8143.75568732939;8149.388795840454;8170.754877353689;8242.629081691219;9656.71029869105;11389.316641001566;11902.404879755804;11976.880231197925;12026.398680065786 01:26:00 INFO - PROCESS | 28645 | |3;mootools.html;1278.7762141625212;1449.1956963885045;1466.0470694048868;1576.9448069317575;1704.250129942825;8210.712625058124;8529.317654587627;8591.785205369868;8835.07231740666;8862.68980585678;8497.575121243928;8725.301975841934;8748;8752.649894004233;8761.737147885573;2259.0737797502984;2297.253392647388;2298.333483289844;2298.5747636687183;2299.7470278269375;2209.6133176694093;2210.9226177083806;2264.4565304326925;2265.4336415896028;2267.047839907243;2257.808086312665;2271.5002699406105;2280.0879648140713;2320.3619004773736;2322.3381336319067;2187.5187458759046;2213.1700612270397;2218.911243550256;2220.3006053093304;2221.6667499875066;2191.583599116163;2198.5383069555414;2200.0979598364593;2202.537467131904;2202.9228976985887;8371.874421883676;8587.141285871425;8606.827863442697;8673.653053877837;8807.64769409223;5010.674306170124;5089.389273287229;5089.618278629117;5090.032893750175;5094.872628184288;3155.1796532901612;3246.3669584431045;3254.2840575073446;3290.391277613649;3299.472084466474;1178.5948133891509;1215.1615385384057;1215.4773447417606;1220.0361714245735;1221.3343727668353;12214.450349734283;12371.072169587316;12378.381080945917;12413.06901982355;12435;4328.11273688893;4405.163019026375;4439.267520859086;4470.441194850644;4504.977475112669;9707.90292097084;9708.368956017835;9731.854022189673;9752.609895604239;9761.463119528495;5028.673136246132;5086.821961231339;5130.179171332569;5141.5886729061585;5145.614078944094;4190.790460476964;4215.578442155821;4335.869923902288;4748.857534273978;4813.253945638432;3706.6478684524927;3766.962330376661;3837.827297771607;3848.461215429842;3852.2680690668685;1083.030687534652;1085.0560012788924;1086.603389762731;1096.8025755363951;1120.8094623913955;970.6651205334149;982.7395740128871;991.4646091110719;1006.039232532944;1020.2450186861818;6197.504199664016;6306.306306306303;6310.148130002391;6312.463440607508;6323.9683801580695;449.5316553458611;454.54545454545456;464.844277167146;465.38801476058876;470.50126865522657;4432.623227025674;4464.754438505848;4479.70881892676;4507.887302817456;4509.436320459942;10607.098396636218;10992.120630349553;11040.944795275973;11056.778864422666;11065.059469945145;10165.796684066278;10637.095846853104;10651.520681569347;10914.727131821768;10943;7822.687092516236;7999.200079991954;8020;8027.07688615805;8039.8794018089775;6055.407073897698;6318.747250109944;6337.112804207322;6338.809835704937;6418.743250269937;9653.2277417805;9755.9024409755;9999.550020249251;10018.64934727281;10038.64864729731;9782.657606983721;9908.851367229354;9923.255755818198;9930.106290433607;9934.503274836085;6885.758998435031;7106.324899134574;7106.7157313706875;7723.884141737991;7853.528788272722;7095.82260443493;7954.045514538292;8299.08710041907;8326.875096873431;8577.95711021441;7647.923520764721;7777.688892444239;7782.105057918186;7792.961035194788;7917.208279172037;7589.544627322378;7623.466357355153;7760;7794.766157015299;7885;7143.35709786101;7251.274872512707;7259.274072592699;7259.745908893164;7266.527675701062;5245.449227831175;5435.728213589384;5484.067708489487;5582.972085139549;5647.322321321468;5287.180487024518;5292.708901010481;5419.539339156058;5512.173174023928;5676.489115979582 01:26:00 INFO - PROCESS | 28645 | |4;prototype.html;314.0609577363683;328.2925295987148;332.77537662078123;333.45646596048437;335.90930448778823;5273.815416460425;5402.837914862551;5432.239486471897;5448.700321482322;5485.259489968853;5462.754176062077;5493.23094766733;5499.807506737255;5503.972480137603;5513.173024046395;4218.388333691628;4238.173556156551;4254.383114448403;4257.59552842481;4274.7862606869685;4023.5976402359825;4082.5100987881497;4227.450431443908;4258.44640196774;4281.880469167751;4188.72773269738;4190.182914331706;4190.554258780731;4202;4204.810783514734;4195.7063005589625;4200.907763981356;4212.304969679999;4242.893927651802;4258.318669012943;3622;3706.5173930427777;3746.9625303746884;3770.377887648535;3772.3398405278967;5150;5229.607779416559;5252.872586602432;5256.159014557691;5297.920531192035;4838.879028024292;4860.4896485869185;4863.78112984913;4870.22076467767;4879.682820616648;5474.40150273768;5626.774929002835;5649.096144616883;5652.85867853307;5706.629069110494;4056.979715101435;4072.9185416291507;4077.3272410052305;4080.3879418087226;4080.4287399764057;5874.412558744091;5880.617759845596;5907.379725128885;5912.260967379078;5913.615614985012;3885.2812229737024;4086.366613174963;4143.875683729493;4165.396017577435;4170.812313445902;4148.439960605279;4183.351580504966;4191.455110835572;4193.580641935843;4199.370094485852;4804.375431193992;4805.303231031481;4814.627831068199;4845.30414354973;4860.198067318853;5607.915881261784;5749.275217434752;5769.846030793774;5771.7865957851;5804.593678442468;1368.4868174434587;1404.4101477379525;1425.3728359521776;1458.2125652147722;1458.8395276519575;895.7760559860035;925.1997022575558;929.135903609636;932.8554074118523;938.3056538161711;4873.951260487421;4906.754662266872;4909.5090490950615;4919.515644599454;4927.77824997876;5126.15418455958;5136.049830781242;5147.253648220987;5168.966206758663;5176.767045482962;4751.275198010577;4895.657303988686;4900.917110228139;4917.852464426073;4934.901301974012;2755;2766.986165069162;2781.748213304021;2794.882047181103;2798;5237.742941694042;5287.67808047988;5310.973445132827;5314.13036960045;5323.467653234723;5014.34813474246;5240.502152295526;5250.684958902478;5300.575953923677;5357.785688572413;5254.474552544792;5315.707636080053;5338.733063346817;5356.062689029326;5356.634058315105;5079.441261461162;5139.640225184351;5153.613478989016;5203.427622961547;5215.4002289735645;4765.809367625395;5035.899282014412;5066.949330506648;5081.669691470042;5139.588832893285;5266.683998960075;5319.382819682653;5335.413104558573;5342.599305052215;5400.972995134999;3827.8468861245237;3829.1767270037076;3829.368154254517;3845.5193100862393;3860.7645553422635;4844.297576851266;5219.2693022976055;5335.599830012687;5709.372828743788;5850.678212698343;5643.858903527444;5666.801661941812;5711.400302968129;5712.34308054579;5713.514351280188;5710.3433105193435;5710.514606258348;5719.28508936383;5721.170430287668;5740.913886291793;5557.916631250615;5589.273394458694;5618.494335509824;5630.943690563206;5654.434556544313;5656.915146272891;5679.488846003879;5688.459596338341;5702.287214098238;5762.94237057624;5417.593680474059;5561.555075593862;5569.192467092168;5624.187906046976;5675.177099320658 01:26:00 INFO - PROCESS | 28645 | |5;yui.html;720.5892641194517;742.2651574940807;753.1451802204497;764.4839733180102;775.1319320437744;15252.313645885934;15869.04785712858;15926.76109858353;15945.681086378265;15967;14072.22602756848;14961;15151.62120946977;15856.762148567781;15865.84134158658;795.3716563914529;800.1278606319111;801.0547553886427;803;805.472415567804;796.4663675337538;798.317438590003;798.3613109512396;798.8442253760519;800.0119851982796;854.6068808348167;859.9742007739778;860.8923884514436;861.0098386855135;861.0098386855135;852.6631980367782;853.7524118005801;853.8249658819927;853.9359548033922;854.6624083487019;613.9539534534883;618.7494064903722;619.5724949784634;620.0513214781391;620.227816368624;13788.379522921492;14092.92953535236;15513.534593962086;15556.844431555766;15566.22168891551;15096.396144154221;15368.615784605363;15384.30770615325;15566.06603603776;15597.298121584443;12224.266544007389;12228;12254.632361029184;12450.937745311307;12495.75008499834;3870.3226935286493;3879.4568760373572;3929.783861887595;3943.5662077171773;4045.656119229869;46058.53941460576;50194.498055019714;67252.663736681;67302.9999999995;76170;11383.88616113845;11462.197646164856;11719.648410547527;11727.179097463095;11763.411829408495;19350.709739353922;19968.800311996984;21995.780042199694;22006.669899951194;22039.33881983543;8537.74386768398;8699.608517616722;8804.955975220082;8847.24798392144;8892.8666070009;4874.734607218684;4894.779734911937;4912.8771780705765;5038.118329292359;5041.0422019816115;3593.083763640307;3667.7065834733157;3700.0934770980743;3704.1850792825535;3707.443883417509;631.2834932351814;662.5660192573775;674.5278305186389;677.2482544375739;684.397729997599;652.2271108736163;716.4662326566742;716.6631683108931;754.4077898849487;754.728297812787;9970.950145249228;10183.879773224939;10248.282620216512;10375.636852710119;10492.370457772558;619.6375120554436;647.6243778608396;676.8003438985511;711.4664001998501;744.8808190689464;4875.926861097087;5000.924986125211;5006.123928312531;5007.148784706608;5028.34631497903;120004;122701.38649306697;123507.38246308891;124693;124850;63056.68471657612;79610.20389796144;98581;101498;101870.49064754778;54565;55797.44202557922;80846;87208;88298.55850720833;10216.868905527002;10489.895101048893;10501.9474902625;10537.73655658584;10656.89343106559;49394.259086114456;50460.49539504705;50863.23705144352;51261.74369128131;52243.216351753996;46978.76510617425;47302.76348618373;47674.76162619165;69160;72403;12831.550895718605;13084.934575327063;13134.737305254033;13318.933405332911;13574.86425135736;14563.271836408348;14674.41302347894;14978.176200309088;15090.094594324375;15920;13956.651083722989;14181.929090354482;14511.564653060424;14526.709465810412;14964.326605302569;13923.373448194652;14218.573442796733;14335.211563364115;14381.568552943429;14840;13043.739125217633;13145.014123940933;13267.668308291984;13298.078934002508;13338.666533336744;11494.82757758651;11590.188686791844;11622.476988535705;11748.765024699629;11874.346910919983;11336.829947550628;11345.319280842845;11581.525542337096;11634.12744044217;11692.181547291608 01:26:00 INFO - PROCESS | 28645 | __end_tp_report 01:26:00 INFO - PROCESS | 28645 | __start_cc_report 01:26:00 INFO - PROCESS | 28645 | _x_x_mozilla_cycle_collect,1007 01:26:00 INFO - PROCESS | 28645 | __end_cc_report 01:26:00 INFO - PROCESS | 28645 | __startTimestamp1466238360263__endTimestamp 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | ------- Summary: start ------- 01:26:00 INFO - PROCESS | 28645 | Number of tests: 6 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#0] dojo.html Cycles:165 Average:5352.23 Median:5524.81 stddev:614.26 (11.1%) stddev-sans-first:589.60 01:26:00 INFO - PROCESS | 28645 | Values: 3075.1 3075.8 3090.1 3116.4 3126.2 5190.8 5236.8 5331.5 5395.6 5431.4 5309.3 5324.3 5384.4 5444.5 5466.9 4795.7 4823.8 4831.8 4924.4 4936.8 4934.1 4980.9 4993.9 4998.8 5048.4 4791.2 4819.8 4922.5 4924.0 4954.6 4883.9 4918.3 4919.8 4936.2 4990.7 4861.5 4873.3 4900.3 4906.7 4938.7 5300.2 5341.3 5383.8 5420.2 5460.3 5807.3 5823.7 5829.9 5831.1 5852.0 5871.7 5877.7 5890.1 5909.2 5919.1 5273.1 5279.6 5345.4 5346.5 5448.8 5852.8 5861.3 5910.4 5910.9 5923.2 5700.5 5707.5 5708.9 5712.7 5712.7 5609.7 5638.0 5678.6 5738.3 5782.5 5714.6 5752.2 5756.2 5760.6 5766.2 5530.9 5764.5 5769.5 5769.8 5776.6 4325.4 4341.8 4361.4 4397.3 4421.2 3913.4 3924.4 3933.0 3945.0 3963.1 5310.9 5371.4 5499.2 5500.1 5506.5 5745.6 5824.7 5848.2 5850.3 5900.7 5460.2 5497.9 5500.0 5504.4 5506.0 4852.6 4915.1 4981.2 5013.7 5078.5 6014.7 6018.0 6020.2 6028.7 6070.1 5832.7 5843.4 5844.6 5846.2 5847.9 5797.0 5825.3 5884.9 5924.9 5981.5 5703.4 5706.1 5709.6 5710.9 5717.8 5745.4 5750.5 5779.2 5791.3 5805.7 5505.3 5526.8 5588.3 5612.0 5636.5 5620.1 5622.9 5629.7 5633.8 5636.2 5394.3 5520.0 5524.8 5525.6 5526.9 5488.6 5512.1 5575.5 5583.2 5623.7 5471.4 5503.3 5539.2 5540.7 5554.9 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#1] ext.html Cycles:180 Average:58851.19 Median:19858.69 stddev:119360.68 (601.1%) stddev-sans-first:119615.40 01:26:00 INFO - PROCESS | 28645 | Values: 603.7 627.4 639.6 644.0 648.0 30791.2 42705.8 43535.3 43556.6 43603.0 45106.3 45572.3 45576.8 45596.0 45610.8 8072.9 8937.6 9104.1 10539.8 10819.3 10639.7 10728.9 10733.5 10749.2 10749.9 10806.9 10845.2 10847.9 10852.5 10855.4 8115.8 10444.1 10650.0 10660.3 11018.9 10727.0 10731.0 10789.0 10801.0 10809.3 42410.0 42644.8 42646.6 42650.8 42829.0 3543.9 3702.7 3732.0 3866.0 3895.2 32011.5 32288.0 33156.8 33359.8 33397.3 4441.1 4491.7 4492.4 4566.5 4665.9 335348.0 336370.0 336604.0 336856.0 337312.0 33572.7 59227.4 59894.7 60021.0 60055.0 35147.5 36537.6 36551.8 36561.5 36569.3 12541.1 13263.7 13392.5 13407.5 13480.5 10786.1 11001.8 11005.2 11081.1 11097.8 8274.4 8312.6 8322.4 8378.7 8421.8 3215.3 3261.9 3280.8 3283.9 3302.8 1061.2 1069.3 1114.4 1129.3 1149.0 32007.4 32526.0 32567.7 32666.3 33265.3 1081.3 1092.2 1133.6 1148.7 1231.1 16695.0 17077.3 17320.8 17616.0 17797.9 570675.0 580611.0 580909.0 583216.0 583566.0 59619.1 60216.1 60399.0 60409.4 60431.4 1243.8 1316.7 1321.4 1352.1 1359.2 32520.2 33474.2 33514.5 33708.8 33922.8 49160.5 49700.5 49849.0 49862.0 49907.3 388901.0 392589.0 394391.0 394535.0 394658.0 25405.5 27283.6 28131.7 28429.4 29756.0 47483.8 48356.8 48579.0 49587.8 49683.3 40255.0 41253.2 41609.4 42223.2 42306.0 41198.0 41231.0 41250.2 41674.6 42262.2 38263.0 39445.0 39780.4 39871.0 39997.0 33464.2 36173.5 36647.6 37012.0 37041.3 27677.4 27983.3 28046.0 28171.0 28214.4 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#2] jquery.html Cycles:180 Average:28689.43 Median:34615.25 stddev:82998.34 (239.8%) stddev-sans-first:83203.94 01:26:00 INFO - PROCESS | 28645 | Values: 373.7 380.3 380.7 382.4 393.9 18022.5 19456.6 19801.8 20413.7 20434.8 18859.5 18944.4 18993.2 19198.4 19564.0 5392.1 5455.3 5601.5 5605.6 5649.4 5523.5 5588.6 5592.5 5608.2 5614.6 5333.9 5538.1 5559.7 5559.7 5599.5 5509.5 5545.9 5555.1 5556.2 5563.7 4954.8 4997.4 5001.0 5030.6 5057.5 22150.3 22241.6 22416.3 22439.9 22576.5 2475.4 2548.5 2561.7 2860.4 3046.5 7848.1 12432.9 14448.3 14561.7 15008.8 1905.8 1959.9 1971.5 2001.1 2022.9 73580.6 73816.6 75289.6 75492.6 77052.0 10223.7 10301.6 10580.8 10617.7 10783.1 14471.9 14508.5 14673.4 14698.3 14732.6 6978.7 7507.8 7523.3 7544.8 7554.3 7029.1 7031.9 7132.4 7152.4 7155.3 6372.6 6555.0 6564.2 6654.3 6734.1 1873.0 1896.2 1912.0 1946.6 1973.3 897.8 974.7 979.4 1015.6 1025.8 18422.4 18957.9 18973.2 19146.8 19656.0 960.7 978.8 981.4 993.7 997.7 10279.7 10806.5 10846.8 10956.5 11004.1 464199.0 471530.0 517355.9 533163.0 537804.0 63938.4 81257.0 83682.2 89098.6 89223.6 1006.7 1007.7 1024.2 1044.6 1052.4 13602.7 16697.6 17033.9 18015.8 18212.9 32041.7 37188.8 39553.4 41421.2 41442.4 46258.8 55259.2 55884.4 56155.4 57678.4 5621.1 6315.5 7790.8 8208.8 8254.4 12270.0 13154.3 13408.3 13419.1 13580.7 11311.3 11504.4 11668.9 11684.6 11846.8 11122.4 11417.6 11698.6 12076.4 12091.5 11702.9 11838.3 11854.1 11901.3 11966.2 8054.0 8143.8 8149.4 8170.8 8242.6 9656.7 11389.3 11902.4 11976.9 12026.4 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#3] mootools.html Cycles:180 Average:5725.63 Median:5057.75 stddev:3271.05 (64.7%) stddev-sans-first:3263.16 01:26:00 INFO - PROCESS | 28645 | Values: 1278.8 1449.2 1466.0 1576.9 1704.3 8210.7 8529.3 8591.8 8835.1 8862.7 8497.6 8725.3 8748.0 8752.6 8761.7 2259.1 2297.3 2298.3 2298.6 2299.7 2209.6 2210.9 2264.5 2265.4 2267.0 2257.8 2271.5 2280.1 2320.4 2322.3 2187.5 2213.2 2218.9 2220.3 2221.7 2191.6 2198.5 2200.1 2202.5 2202.9 8371.9 8587.1 8606.8 8673.7 8807.6 5010.7 5089.4 5089.6 5090.0 5094.9 3155.2 3246.4 3254.3 3290.4 3299.5 1178.6 1215.2 1215.5 1220.0 1221.3 12214.5 12371.1 12378.4 12413.1 12435.0 4328.1 4405.2 4439.3 4470.4 4505.0 9707.9 9708.4 9731.9 9752.6 9761.5 5028.7 5086.8 5130.2 5141.6 5145.6 4190.8 4215.6 4335.9 4748.9 4813.3 3706.6 3767.0 3837.8 3848.5 3852.3 1083.0 1085.1 1086.6 1096.8 1120.8 970.7 982.7 991.5 1006.0 1020.2 6197.5 6306.3 6310.1 6312.5 6324.0 449.5 454.5 464.8 465.4 470.5 4432.6 4464.8 4479.7 4507.9 4509.4 10607.1 10992.1 11040.9 11056.8 11065.1 10165.8 10637.1 10651.5 10914.7 10943.0 7822.7 7999.2 8020.0 8027.1 8039.9 6055.4 6318.7 6337.1 6338.8 6418.7 9653.2 9755.9 9999.6 10018.6 10038.6 9782.7 9908.9 9923.3 9930.1 9934.5 6885.8 7106.3 7106.7 7723.9 7853.5 7095.8 7954.0 8299.1 8326.9 8578.0 7647.9 7777.7 7782.1 7793.0 7917.2 7589.5 7623.5 7760.0 7794.8 7885.0 7143.4 7251.3 7259.3 7259.7 7266.5 5245.4 5435.7 5484.1 5583.0 5647.3 5287.2 5292.7 5419.5 5512.2 5676.5 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#4] prototype.html Cycles:180 Average:4590.96 Median:5143.45 stddev:1328.79 (25.8%) stddev-sans-first:1293.16 01:26:00 INFO - PROCESS | 28645 | Values: 314.1 328.3 332.8 333.5 335.9 5273.8 5402.8 5432.2 5448.7 5485.3 5462.8 5493.2 5499.8 5504.0 5513.2 4218.4 4238.2 4254.4 4257.6 4274.8 4023.6 4082.5 4227.5 4258.4 4281.9 4188.7 4190.2 4190.6 4202.0 4204.8 4195.7 4200.9 4212.3 4242.9 4258.3 3622.0 3706.5 3747.0 3770.4 3772.3 5150.0 5229.6 5252.9 5256.2 5297.9 4838.9 4860.5 4863.8 4870.2 4879.7 5474.4 5626.8 5649.1 5652.9 5706.6 4057.0 4072.9 4077.3 4080.4 4080.4 5874.4 5880.6 5907.4 5912.3 5913.6 3885.3 4086.4 4143.9 4165.4 4170.8 4148.4 4183.4 4191.5 4193.6 4199.4 4804.4 4805.3 4814.6 4845.3 4860.2 5607.9 5749.3 5769.8 5771.8 5804.6 1368.5 1404.4 1425.4 1458.2 1458.8 895.8 925.2 929.1 932.9 938.3 4874.0 4906.8 4909.5 4919.5 4927.8 5126.2 5136.0 5147.3 5169.0 5176.8 4751.3 4895.7 4900.9 4917.9 4934.9 2755.0 2767.0 2781.7 2794.9 2798.0 5237.7 5287.7 5311.0 5314.1 5323.5 5014.3 5240.5 5250.7 5300.6 5357.8 5254.5 5315.7 5338.7 5356.1 5356.6 5079.4 5139.6 5153.6 5203.4 5215.4 4765.8 5035.9 5066.9 5081.7 5139.6 5266.7 5319.4 5335.4 5342.6 5401.0 3827.8 3829.2 3829.4 3845.5 3860.8 4844.3 5219.3 5335.6 5709.4 5850.7 5643.9 5666.8 5711.4 5712.3 5713.5 5710.3 5710.5 5719.3 5721.2 5740.9 5557.9 5589.3 5618.5 5630.9 5654.4 5656.9 5679.5 5688.5 5702.3 5762.9 5417.6 5561.6 5569.2 5624.2 5675.2 01:26:00 INFO - PROCESS | 28645 | 01:26:00 INFO - PROCESS | 28645 | [#5] yui.html Cycles:180 Average:19662.32 Median:3788.88 stddev:28035.92 (740.0%) stddev-sans-first:28078.49 01:26:00 INFO - PROCESS | 28645 | Values: 720.6 742.3 753.1 764.5 775.1 15252.3 15869.0 15926.8 15945.7 15967.0 14072.2 14961.0 15151.6 15856.8 15865.8 795.4 800.1 801.1 803.0 805.5 796.5 798.3 798.4 798.8 800.0 854.6 860.0 860.9 861.0 861.0 852.7 853.8 853.8 853.9 854.7 614.0 618.7 619.6 620.1 620.2 13788.4 14092.9 15513.5 15556.8 15566.2 15096.4 15368.6 15384.3 15566.1 15597.3 12224.3 12228.0 12254.6 12450.9 12495.8 3870.3 3879.5 3929.8 3943.6 4045.7 46058.5 50194.5 67252.7 67303.0 76170.0 11383.9 11462.2 11719.6 11727.2 11763.4 19350.7 19968.8 21995.8 22006.7 22039.3 8537.7 8699.6 8805.0 8847.2 8892.9 4874.7 4894.8 4912.9 5038.1 5041.0 3593.1 3667.7 3700.1 3704.2 3707.4 631.3 662.6 674.5 677.2 684.4 652.2 716.5 716.7 754.4 754.7 9971.0 10183.9 10248.3 10375.6 10492.4 619.6 647.6 676.8 711.5 744.9 4875.9 5000.9 5006.1 5007.1 5028.3 120004.0 122701.4 123507.4 124693.0 124850.0 63056.7 79610.2 98581.0 101498.0 101870.5 54565.0 55797.4 80846.0 87208.0 88298.6 10216.9 10489.9 10501.9 10537.7 10656.9 49394.3 50460.5 50863.2 51261.7 52243.2 46978.8 47302.8 47674.8 69160.0 72403.0 12831.6 13084.9 13134.7 13318.9 13574.9 14563.3 14674.4 14978.2 15090.1 15920.0 13956.7 14181.9 14511.6 14526.7 14964.3 13923.4 14218.6 14335.2 14381.6 14840.0 13043.7 13145.0 13267.7 13298.1 13338.7 11494.8 11590.2 11622.5 11748.8 11874.3 11336.8 11345.3 11581.5 11634.1 11692.2 01:26:00 INFO - PROCESS | 28645 | -------- Summary: end -------- 01:26:00 INFO - PROCESS | 28645 | 01:26:01 INFO - TEST-INFO | 28645: exit 0 01:26:01 INFO - TEST-OK | dromaeo_css | took 1113248ms 01:26:01 INFO - TEST-START | kraken 01:26:01 INFO - operating with platform_type : linux_ 01:26:01 INFO - Initialising browser for kraken test... 01:26:01 INFO - TEST-INFO | started process 28833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp930rH0/profile http://localhost:35947/getInfo.html) 01:26:04 INFO - PROCESS | 28833 | __metrics Screen width/height:1600/1200 01:26:04 INFO - PROCESS | 28833 | colorDepth:24 01:26:04 INFO - PROCESS | 28833 | Browser inner width/height: 1024/697 01:26:04 INFO - PROCESS | 28833 | __metrics 01:26:05 INFO - PROCESS | 28833 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:06 INFO - TEST-INFO | 28833: exit 0 01:26:06 INFO - Browser initialized. 01:26:06 INFO - Running cycle 1/1 for kraken test... 01:26:06 INFO - TEST-INFO | started process 28913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp930rH0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:18 INFO - PROCESS | 28913 | RSS: Main: 174112768 01:26:18 INFO - PROCESS | 28913 | 01:26:20 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35947/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:21 INFO - PROCESS | 28913 | RSS: Main: 233013248 01:26:21 INFO - PROCESS | 28913 | 01:26:24 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35947/tests/kraken/driver.html?testName=audio-dft) 01:26:25 INFO - PROCESS | 28913 | RSS: Main: 220672000 01:26:25 INFO - PROCESS | 28913 | 01:26:28 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35947/tests/kraken/driver.html?testName=audio-fft) 01:26:28 INFO - PROCESS | 28913 | RSS: Main: 286932992 01:26:28 INFO - PROCESS | 28913 | 01:26:30 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35947/tests/kraken/driver.html?testName=audio-oscillator) 01:26:31 INFO - PROCESS | 28913 | RSS: Main: 197980160 01:26:31 INFO - PROCESS | 28913 | 01:26:33 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:26:34 INFO - PROCESS | 28913 | RSS: Main: 202113024 01:26:34 INFO - PROCESS | 28913 | 01:26:37 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35947/tests/kraken/driver.html?testName=imaging-darkroom) 01:26:37 INFO - PROCESS | 28913 | RSS: Main: 236974080 01:26:37 INFO - PROCESS | 28913 | 01:26:41 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35947/tests/kraken/driver.html?testName=imaging-desaturate) 01:26:41 INFO - PROCESS | 28913 | RSS: Main: 238739456 01:26:41 INFO - PROCESS | 28913 | 01:26:44 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35947/tests/kraken/driver.html?testName=json-parse-financial) 01:26:45 INFO - PROCESS | 28913 | RSS: Main: 239022080 01:26:45 INFO - PROCESS | 28913 | 01:26:46 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:26:47 INFO - PROCESS | 28913 | RSS: Main: 228114432 01:26:47 INFO - PROCESS | 28913 | 01:26:49 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:26:49 INFO - PROCESS | 28913 | RSS: Main: 229507072 01:26:49 INFO - PROCESS | 28913 | 01:26:51 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:26:52 INFO - PROCESS | 28913 | RSS: Main: 237522944 01:26:52 INFO - PROCESS | 28913 | 01:26:55 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:26:55 INFO - PROCESS | 28913 | RSS: Main: 239054848 01:26:55 INFO - PROCESS | 28913 | 01:26:58 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:59 INFO - PROCESS | 28913 | RSS: Main: 239157248 01:26:59 INFO - PROCESS | 28913 | 01:27:00 INFO - PROCESS | 28913 | Cycle 1(1): loaded http://localhost:35947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35947/tests/kraken/driver.html?testName=ai-astar) 01:27:01 INFO - PROCESS | 28913 | RSS: Main: 281841664 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | __start_tp_report 01:27:01 INFO - PROCESS | 28913 | _x_x_mozilla_page_load 01:27:01 INFO - PROCESS | 28913 | _x_x_mozilla_page_load_details 01:27:01 INFO - PROCESS | 28913 | |i|pagename|runs| 01:27:01 INFO - PROCESS | 28913 | |0;ai-astar;110;105;110;110;109;111;110;111;109;109 01:27:01 INFO - PROCESS | 28913 | |1;audio-beat-detection;155;131;129;180;128;130;155;125;159;126 01:27:01 INFO - PROCESS | 28913 | |2;audio-dft;160;161;161;160;159;161;160;161;161;160 01:27:01 INFO - PROCESS | 28913 | |3;audio-fft;75;75;76;131;76;76;75;74;108;77 01:27:01 INFO - PROCESS | 28913 | |4;audio-oscillator;86;86;113;87;86;86;121;86;85;122 01:27:01 INFO - PROCESS | 28913 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 01:27:01 INFO - PROCESS | 28913 | |6;imaging-darkroom;146;146;147;146;147;146;145;145;146;146 01:27:01 INFO - PROCESS | 28913 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 01:27:01 INFO - PROCESS | 28913 | |8;json-parse-financial;52;53;55;54;53;52;64;54;52;53 01:27:01 INFO - PROCESS | 28913 | |9;json-stringify-tinderbox;62;63;62;62;61;63;63;63;63;64 01:27:01 INFO - PROCESS | 28913 | |10;stanford-crypto-aes;80;80;84;80;81;81;81;81;110;81 01:27:01 INFO - PROCESS | 28913 | |11;stanford-crypto-ccm;125;124;124;122;121;129;130;124;132;127 01:27:01 INFO - PROCESS | 28913 | |12;stanford-crypto-pbkdf2;162;163;164;169;162;162;163;164;165;162 01:27:01 INFO - PROCESS | 28913 | |13;stanford-crypto-sha256-iterative;67;66;65;64;66;65;64;65;64;64 01:27:01 INFO - PROCESS | 28913 | __end_tp_report 01:27:01 INFO - PROCESS | 28913 | __start_cc_report 01:27:01 INFO - PROCESS | 28913 | _x_x_mozilla_cycle_collect,1614 01:27:01 INFO - PROCESS | 28913 | __end_cc_report 01:27:01 INFO - PROCESS | 28913 | __startTimestamp1466238421076__endTimestamp 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | ------- Summary: start ------- 01:27:01 INFO - PROCESS | 28913 | Number of tests: 14 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.80 01:27:01 INFO - PROCESS | 28913 | Values: 110.0 105.0 110.0 110.0 109.0 111.0 110.0 111.0 109.0 109.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:143.00 stddev:18.99 (13.3%) stddev-sans-first:19.53 01:27:01 INFO - PROCESS | 28913 | Values: 155.0 131.0 129.0 180.0 128.0 130.0 155.0 125.0 159.0 126.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 01:27:01 INFO - PROCESS | 28913 | Values: 160.0 161.0 161.0 160.0 159.0 161.0 160.0 161.0 161.0 160.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#3] audio-fft Cycles:10 Average:84.30 Median:75.50 stddev:19.35 (25.6%) stddev-sans-first:20.22 01:27:01 INFO - PROCESS | 28913 | Values: 75.0 75.0 76.0 131.0 76.0 76.0 75.0 74.0 108.0 77.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:86.00 stddev:15.96 (18.6%) stddev-sans-first:16.53 01:27:01 INFO - PROCESS | 28913 | Values: 86.0 86.0 113.0 87.0 86.0 86.0 121.0 86.0 85.0 122.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:27:01 INFO - PROCESS | 28913 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:27:01 INFO - PROCESS | 28913 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 145.0 145.0 146.0 146.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:27:01 INFO - PROCESS | 28913 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:3.58 (6.7%) stddev-sans-first:3.71 01:27:01 INFO - PROCESS | 28913 | Values: 52.0 53.0 55.0 54.0 53.0 52.0 64.0 54.0 52.0 53.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 01:27:01 INFO - PROCESS | 28913 | Values: 62.0 63.0 62.0 62.0 61.0 63.0 63.0 63.0 63.0 64.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:9.24 (11.4%) stddev-sans-first:9.70 01:27:01 INFO - PROCESS | 28913 | Values: 80.0 80.0 84.0 80.0 81.0 81.0 81.0 81.0 110.0 81.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:3.58 (2.8%) stddev-sans-first:3.79 01:27:01 INFO - PROCESS | 28913 | Values: 125.0 124.0 124.0 122.0 121.0 129.0 130.0 124.0 132.0 127.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.50 stddev:2.17 (1.3%) stddev-sans-first:2.22 01:27:01 INFO - PROCESS | 28913 | Values: 162.0 163.0 164.0 169.0 162.0 162.0 163.0 164.0 165.0 162.0 01:27:01 INFO - PROCESS | 28913 | 01:27:01 INFO - PROCESS | 28913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 01:27:01 INFO - PROCESS | 28913 | Values: 67.0 66.0 65.0 64.0 66.0 65.0 64.0 65.0 64.0 64.0 01:27:01 INFO - PROCESS | 28913 | -------- Summary: end -------- 01:27:01 INFO - PROCESS | 28913 | 01:27:02 INFO - TEST-INFO | 28913: exit 0 01:27:02 INFO - TEST-OK | kraken | took 61115ms 01:27:02 INFO - SUITE-END | took 1174s 01:27:02 INFO - Completed test suite (00:19:34) 01:27:02 INFO - javascript benchmark 01:27:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.138961090894, 3075.8308293043883, 3090.119315994941, 3116.439040972624, 3126.2497000719836, 5190.8442746717565, 5236.7905283788605, 5331.546818520425, 5395.595330350225, 5431.402545719972, 5309.283246761686, 5324.307839980797, 5384.40771515133, 5444.50999410053, 5466.890662186754, 4795.736234507101, 4823.8070477181045, 4831.7584120794, 4924.384451943507, 4936.7778449969655, 4934.062528119646, 4980.850574482772, 4993.875153121165, 4998.775055122528, 5048.394192696882, 4791.161546729309, 4819.759012049419, 4922.483139270379, 4924.015196960604, 4954.554090131887, 4883.8779030524165, 4918.311436398872, 4919.7540122993705, 4936.185529387682, 4990.65065445419, 4861.513848615145, 4873.31773551703, 4900.313956046157, 4906.656534042619, 4938.703677779309, 5300.151975683911, 5341.278927344798, 5383.811566595189, 5420.159875219348, 5460.34475862899, 5807.30312362515, 5823.67969761663, 5829.941700582982, 5831.096180092092, 5852.0, 5871.677057761822, 5877.67672777997, 5890.116482527612, 5909.172715819789, 5919.1417244499735, 5273.077211487975, 5279.577633789326, 5345.3852806926925, 5346.492083252085, 5448.782048718046, 5852.795152169653, 5861.325947516005, 5910.379410161957, 5910.8817823643285, 5923.200367950271, 5700.4869561738815, 5707.486326230659, 5708.857278568069, 5712.714364281769, 5712.714364281769, 5609.691466969356, 5638.0, 5678.630888992285, 5738.282714660668, 5782.479576838105, 5714.599978001583, 5752.223449834302, 5756.165356023437, 5760.596758226968, 5766.192733017381, 5530.944690553123, 5764.481196692318, 5769.538436925036, 5769.769209231667, 5776.624519406225, 4325.351197320364, 4341.7829108545075, 4361.433013708198, 4397.274449715825, 4421.248387774086, 3913.4325522799036, 3924.3917192835156, 3933.0, 3944.9605503944595, 3963.0884896473394, 5310.946890531045, 5371.355437347465, 5499.230107784913, 5500.064988951888, 5506.531944784738, 5745.626534275259, 5824.6796426196115, 5848.152017957373, 5850.297964244318, 5900.734466948998, 5460.208269800936, 5497.917531237034, 5500.0, 5504.394516603171, 5506.0, 4852.611791056707, 4915.139850526144, 4981.178105612534, 5013.724245166478, 5078.492150784966, 6014.669193194329, 6017.969910150421, 6020.217371741645, 6028.668423236676, 6070.0591408331775, 5832.650040997553, 5843.415658434123, 5844.649321040752, 5846.239988801429, 5847.853803654943, 5796.971015144897, 5825.300963884361, 5884.941150588439, 5924.851878703067, 5981.491573216325, 5703.401142880104, 5706.115552089433, 5709.628874123168, 5710.914336285042, 5717.771289148387, 5745.396733342939, 5750.453706897838, 5779.219805326227, 5791.305043394819, 5805.680687562224, 5505.311836020497, 5526.806561770319, 5588.30146231721, 5611.971940140274, 5636.549076073822, 5620.12888002344, 5622.915656265078, 5629.662220266797, 5633.774649013993, 5636.1827535008015, 5394.2987411637805, 5519.972400137974, 5524.806631767869, 5525.585581081516, 5526.944730552804, 5488.588355873246, 5512.062949298549, 5575.526080283222, 5583.218349431002, 5623.690697011703, 5471.425500322409, 5503.257060296809, 5539.224508568723, 5540.722963851711, 5554.944450555443], "value": 5310.252094417203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6709993053785, 627.4478458956117, 639.5555089212996, 643.9985822046718, 648.031193365918, 30791.230219244502, 42705.78647106768, 43535.3469697954, 43556.56443435565, 43603.0, 45106.32340514895, 45572.316415253714, 45576.77211613937, 45596.0, 45610.7719461403, 8072.878906816373, 8937.55312234389, 9104.135107164842, 10539.789204215911, 10819.296745711543, 10639.680809575726, 10728.892711072867, 10733.51699173539, 10749.247552671317, 10749.946250268738, 10806.891931080707, 10845.240833141683, 10847.945760271226, 10852.457377131152, 10855.40295283759, 8115.823205635179, 10444.112250458682, 10650.0, 10660.307080039773, 11018.889811101946, 10727.034566889017, 10731.0, 10789.0, 10800.973907478778, 10809.297395669257, 42410.0, 42644.78677606592, 42646.57353426457, 42650.786746066384, 42829.0, 3543.929121417583, 3702.685271751904, 3732.029672285198, 3866.033491627093, 3895.18201177753, 32011.51982720261, 32288.0, 33156.83421582901, 33359.83320083384, 33397.3320533588, 4441.111777644484, 4491.702176494658, 4492.415985921842, 4566.54334566544, 4665.930011049837, 335348.0, 336370.0, 336604.0, 336856.0, 337312.0, 33572.66427335695, 59227.407725923054, 59894.70052649796, 60021.0, 60055.0, 35147.4727879082, 36537.634623653954, 36551.817240913624, 36561.45157822635, 36569.26861462756, 12541.122121451594, 13263.73472530544, 13392.464301428028, 13407.530736424178, 13480.460781568823, 10786.137109031259, 11001.779964400666, 11005.229633925548, 11081.113510919107, 11097.778044439228, 8274.420790544724, 8312.584370781558, 8322.417430779908, 8378.706745264008, 8421.789455263544, 3215.324781795802, 3261.8532166052582, 3280.819554924502, 3283.885064022748, 3302.8348582570775, 1061.2093989977361, 1069.337011053152, 1114.4483480676954, 1129.3393364881636, 1148.9597864074885, 32007.359852802812, 32526.0, 32567.674323256466, 32666.346673066404, 33265.334693305995, 1081.297156848055, 1092.186321190718, 1133.5975728616388, 1148.724306166514, 1231.07054174098, 16695.0, 17077.31690732357, 17320.826791732172, 17616.0, 17797.911010445125, 570675.0, 580611.0, 580909.0, 583216.0, 583566.0, 59619.10571341347, 60216.09675854866, 60399.0, 60409.39590604125, 60431.395686042575, 1243.8445194350707, 1316.7103237287781, 1321.4185758266333, 1352.1278775190144, 1359.157322460081, 32520.186995325304, 33474.16314592155, 33514.49728254127, 33708.83145584256, 33922.83038584791, 49160.508394915596, 49700.50299497104, 49849.0, 49862.0, 49907.25139122989, 388901.0, 392589.0, 394391.0, 394535.0, 394658.0, 25405.491890161724, 27283.590746138427, 28131.71868281291, 28429.431411372072, 29756.0, 47483.76258118687, 48356.75821620869, 48579.0, 49587.752061240906, 49683.254751179484, 40255.0, 41253.1749365005, 41609.37585936153, 42223.15553688847, 42306.0, 41198.0, 41231.0, 41250.1749964993, 41674.58325416828, 42262.15475690408, 38262.95297993478, 39445.0, 39780.403293951196, 39871.0, 39997.0, 33464.1633959153, 36173.457398138526, 36647.63352366549, 37012.0, 37041.25917481689, 27677.446451071268, 27983.300417489725, 28046.0, 28171.0, 28214.43571128525], "value": 19263.189888193196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.6786363727195, 380.2660864531455, 380.7468033757551, 382.3805435194985, 393.9074317535377, 18022.5494362641, 19456.610867782634, 19801.801981980178, 20413.693794593073, 20434.795652043475, 18859.52851178718, 18944.431667049976, 18993.240270389204, 19198.424047278568, 19564.0, 5392.056390131731, 5455.345358556969, 5601.467860553262, 5605.607607467479, 5649.350324712669, 5523.475269849358, 5588.552915766729, 5592.468715472024, 5608.214849921014, 5614.606977511576, 5333.946660533384, 5538.141588053858, 5559.666420014792, 5559.694216818073, 5599.524040456566, 5509.531689806371, 5545.861353466155, 5555.083411237141, 5556.194351818984, 5563.666180029211, 4954.826581069681, 4997.425296090923, 5000.974995125038, 5030.622703297231, 5057.4689657585795, 22150.33548993533, 22241.55516889669, 22416.32751017472, 22439.887800560893, 22576.548469030527, 2475.4306509502735, 2548.5157820014324, 2561.731018243076, 2860.356419805548, 3046.4973279408873, 7848.058233012075, 12432.937835310857, 14448.277586120757, 14561.708765824624, 15008.774868376982, 1905.8380037696813, 1959.9314024009234, 1971.4578490914969, 2001.0595020340418, 2022.8685135466148, 73580.6320968397, 73816.6309168456, 75289.62355188244, 75492.62253688752, 77052.0, 10223.693289201336, 10301.639442619473, 10580.841287380696, 10617.73455663599, 10783.13734901206, 14471.85528144726, 14508.492202772852, 14673.413063477556, 14698.26508674562, 14732.631684207767, 6978.685959131852, 7507.849843003219, 7523.3229009389415, 7544.773656790305, 7554.2823431773895, 7029.0862187915245, 7031.929680703128, 7132.358087772125, 7152.427805775629, 7155.284471552803, 6372.6495042773095, 6554.967225163844, 6564.212294524687, 6654.3345665434035, 6734.090897728744, 1873.0198328551828, 1896.2130715753083, 1911.9808801912081, 1946.571754214099, 1973.319204874316, 897.7710683775596, 974.741693451236, 979.4417182206216, 1015.6140666546665, 1025.8153532364247, 18422.434093102238, 18957.90521047386, 18973.241070357308, 19146.80853191478, 19656.017199139987, 960.7309953213112, 978.8189185000798, 981.3621146254991, 993.7068564773409, 997.7356000659831, 10279.715035620547, 10806.459677016275, 10846.78306433867, 10956.506957186946, 11004.119670426348, 464199.0, 471530.0, 517355.89254375914, 533163.0, 537804.0, 63938.36061639417, 81257.0, 83682.16317836744, 89098.55450722705, 89223.55388223147, 1006.6778630838062, 1007.7228762090484, 1024.1857723110145, 1044.6343779677052, 1052.4106500359824, 13602.659933501742, 16697.582560436087, 17033.91483042577, 18015.819841801414, 18212.908935455238, 32041.6795832048, 37188.81405592955, 39553.406698898965, 41421.1715765689, 41442.37836432516, 46258.768706156254, 55259.171112432545, 55884.44115558955, 56155.43844561502, 57678.423215768984, 5621.100623900156, 6315.4947604192475, 7790.805229869298, 8208.753737387888, 8254.42219044661, 12270.0, 13154.34228288601, 13408.32958352098, 13419.127756695783, 13580.728385432434, 11311.264767790068, 11504.36725980079, 11668.88331116678, 11684.649460516199, 11846.822297665714, 11122.443877805916, 11417.60038398652, 11698.649040528799, 12076.396180191132, 12091.516339346328, 11702.941485292518, 11838.348890811088, 11854.11094167958, 11901.345426001306, 11966.22219555726, 8054.0, 8143.75568732939, 8149.388795840454, 8170.754877353689, 8242.629081691219, 9656.71029869105, 11389.316641001566, 11902.404879755804, 11976.880231197925, 12026.398680065786], "value": 9096.084164727592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.7762141625212, 1449.1956963885045, 1466.0470694048868, 1576.9448069317575, 1704.250129942825, 8210.712625058124, 8529.317654587627, 8591.785205369868, 8835.07231740666, 8862.68980585678, 8497.575121243928, 8725.301975841934, 8748.0, 8752.649894004233, 8761.737147885573, 2259.0737797502984, 2297.253392647388, 2298.333483289844, 2298.5747636687183, 2299.7470278269375, 2209.6133176694093, 2210.9226177083806, 2264.4565304326925, 2265.4336415896028, 2267.047839907243, 2257.808086312665, 2271.5002699406105, 2280.0879648140713, 2320.3619004773736, 2322.3381336319067, 2187.5187458759046, 2213.1700612270397, 2218.911243550256, 2220.3006053093304, 2221.6667499875066, 2191.583599116163, 2198.5383069555414, 2200.0979598364593, 2202.537467131904, 2202.9228976985887, 8371.874421883676, 8587.141285871425, 8606.827863442697, 8673.653053877837, 8807.64769409223, 5010.674306170124, 5089.389273287229, 5089.618278629117, 5090.032893750175, 5094.872628184288, 3155.1796532901612, 3246.3669584431045, 3254.2840575073446, 3290.391277613649, 3299.472084466474, 1178.5948133891509, 1215.1615385384057, 1215.4773447417606, 1220.0361714245735, 1221.3343727668353, 12214.450349734283, 12371.072169587316, 12378.381080945917, 12413.06901982355, 12435.0, 4328.11273688893, 4405.163019026375, 4439.267520859086, 4470.441194850644, 4504.977475112669, 9707.90292097084, 9708.368956017835, 9731.854022189673, 9752.609895604239, 9761.463119528495, 5028.673136246132, 5086.821961231339, 5130.179171332569, 5141.5886729061585, 5145.614078944094, 4190.790460476964, 4215.578442155821, 4335.869923902288, 4748.857534273978, 4813.253945638432, 3706.6478684524927, 3766.962330376661, 3837.827297771607, 3848.461215429842, 3852.2680690668685, 1083.030687534652, 1085.0560012788924, 1086.603389762731, 1096.8025755363951, 1120.8094623913955, 970.6651205334149, 982.7395740128871, 991.4646091110719, 1006.039232532944, 1020.2450186861818, 6197.504199664016, 6306.306306306303, 6310.148130002391, 6312.463440607508, 6323.9683801580695, 449.5316553458611, 454.54545454545456, 464.844277167146, 465.38801476058876, 470.50126865522657, 4432.623227025674, 4464.754438505848, 4479.70881892676, 4507.887302817456, 4509.436320459942, 10607.098396636218, 10992.120630349553, 11040.944795275973, 11056.778864422666, 11065.059469945145, 10165.796684066278, 10637.095846853104, 10651.520681569347, 10914.727131821768, 10943.0, 7822.687092516236, 7999.200079991954, 8020.0, 8027.07688615805, 8039.8794018089775, 6055.407073897698, 6318.747250109944, 6337.112804207322, 6338.809835704937, 6418.743250269937, 9653.2277417805, 9755.9024409755, 9999.550020249251, 10018.64934727281, 10038.64864729731, 9782.657606983721, 9908.851367229354, 9923.255755818198, 9930.106290433607, 9934.503274836085, 6885.758998435031, 7106.324899134574, 7106.7157313706875, 7723.884141737991, 7853.528788272722, 7095.82260443493, 7954.045514538292, 8299.08710041907, 8326.875096873431, 8577.95711021441, 7647.923520764721, 7777.688892444239, 7782.105057918186, 7792.961035194788, 7917.208279172037, 7589.544627322378, 7623.466357355153, 7760.0, 7794.766157015299, 7885.0, 7143.35709786101, 7251.274872512707, 7259.274072592699, 7259.745908893164, 7266.527675701062, 5245.449227831175, 5435.728213589384, 5484.067708489487, 5582.972085139549, 5647.322321321468, 5287.180487024518, 5292.708901010481, 5419.539339156058, 5512.173174023928, 5676.489115979582], "value": 4495.8636922827955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.0609577363683, 328.2925295987148, 332.77537662078123, 333.45646596048437, 335.90930448778823, 5273.815416460425, 5402.837914862551, 5432.239486471897, 5448.700321482322, 5485.259489968853, 5462.754176062077, 5493.23094766733, 5499.807506737255, 5503.972480137603, 5513.173024046395, 4218.388333691628, 4238.173556156551, 4254.383114448403, 4257.59552842481, 4274.7862606869685, 4023.5976402359825, 4082.5100987881497, 4227.450431443908, 4258.44640196774, 4281.880469167751, 4188.72773269738, 4190.182914331706, 4190.554258780731, 4202.0, 4204.810783514734, 4195.7063005589625, 4200.907763981356, 4212.304969679999, 4242.893927651802, 4258.318669012943, 3622.0, 3706.5173930427777, 3746.9625303746884, 3770.377887648535, 3772.3398405278967, 5150.0, 5229.607779416559, 5252.872586602432, 5256.159014557691, 5297.920531192035, 4838.879028024292, 4860.4896485869185, 4863.78112984913, 4870.22076467767, 4879.682820616648, 5474.40150273768, 5626.774929002835, 5649.096144616883, 5652.85867853307, 5706.629069110494, 4056.979715101435, 4072.9185416291507, 4077.3272410052305, 4080.3879418087226, 4080.4287399764057, 5874.412558744091, 5880.617759845596, 5907.379725128885, 5912.260967379078, 5913.615614985012, 3885.2812229737024, 4086.366613174963, 4143.875683729493, 4165.396017577435, 4170.812313445902, 4148.439960605279, 4183.351580504966, 4191.455110835572, 4193.580641935843, 4199.370094485852, 4804.375431193992, 4805.303231031481, 4814.627831068199, 4845.30414354973, 4860.198067318853, 5607.915881261784, 5749.275217434752, 5769.846030793774, 5771.7865957851, 5804.593678442468, 1368.4868174434587, 1404.4101477379525, 1425.3728359521776, 1458.2125652147722, 1458.8395276519575, 895.7760559860035, 925.1997022575558, 929.135903609636, 932.8554074118523, 938.3056538161711, 4873.951260487421, 4906.754662266872, 4909.5090490950615, 4919.515644599454, 4927.77824997876, 5126.15418455958, 5136.049830781242, 5147.253648220987, 5168.966206758663, 5176.767045482962, 4751.275198010577, 4895.657303988686, 4900.917110228139, 4917.852464426073, 4934.901301974012, 2755.0, 2766.986165069162, 2781.748213304021, 2794.882047181103, 2798.0, 5237.742941694042, 5287.67808047988, 5310.973445132827, 5314.13036960045, 5323.467653234723, 5014.34813474246, 5240.502152295526, 5250.684958902478, 5300.575953923677, 5357.785688572413, 5254.474552544792, 5315.707636080053, 5338.733063346817, 5356.062689029326, 5356.634058315105, 5079.441261461162, 5139.640225184351, 5153.613478989016, 5203.427622961547, 5215.4002289735645, 4765.809367625395, 5035.899282014412, 5066.949330506648, 5081.669691470042, 5139.588832893285, 5266.683998960075, 5319.382819682653, 5335.413104558573, 5342.599305052215, 5400.972995134999, 3827.8468861245237, 3829.1767270037076, 3829.368154254517, 3845.5193100862393, 3860.7645553422635, 4844.297576851266, 5219.2693022976055, 5335.599830012687, 5709.372828743788, 5850.678212698343, 5643.858903527444, 5666.801661941812, 5711.400302968129, 5712.34308054579, 5713.514351280188, 5710.3433105193435, 5710.514606258348, 5719.28508936383, 5721.170430287668, 5740.913886291793, 5557.916631250615, 5589.273394458694, 5618.494335509824, 5630.943690563206, 5654.434556544313, 5656.915146272891, 5679.488846003879, 5688.459596338341, 5702.287214098238, 5762.94237057624, 5417.593680474059, 5561.555075593862, 5569.192467092168, 5624.187906046976, 5675.177099320658], "value": 4167.0459023324365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5892641194517, 742.2651574940807, 753.1451802204497, 764.4839733180102, 775.1319320437744, 15252.313645885934, 15869.04785712858, 15926.76109858353, 15945.681086378265, 15967.0, 14072.22602756848, 14961.0, 15151.62120946977, 15856.762148567781, 15865.84134158658, 795.3716563914529, 800.1278606319111, 801.0547553886427, 803.0, 805.472415567804, 796.4663675337538, 798.317438590003, 798.3613109512396, 798.8442253760519, 800.0119851982796, 854.6068808348167, 859.9742007739778, 860.8923884514436, 861.0098386855135, 861.0098386855135, 852.6631980367782, 853.7524118005801, 853.8249658819927, 853.9359548033922, 854.6624083487019, 613.9539534534883, 618.7494064903722, 619.5724949784634, 620.0513214781391, 620.227816368624, 13788.379522921492, 14092.92953535236, 15513.534593962086, 15556.844431555766, 15566.22168891551, 15096.396144154221, 15368.615784605363, 15384.30770615325, 15566.06603603776, 15597.298121584443, 12224.266544007389, 12228.0, 12254.632361029184, 12450.937745311307, 12495.75008499834, 3870.3226935286493, 3879.4568760373572, 3929.783861887595, 3943.5662077171773, 4045.656119229869, 46058.53941460576, 50194.498055019714, 67252.663736681, 67302.9999999995, 76170.0, 11383.88616113845, 11462.197646164856, 11719.648410547527, 11727.179097463095, 11763.411829408495, 19350.709739353922, 19968.800311996984, 21995.780042199694, 22006.669899951194, 22039.33881983543, 8537.74386768398, 8699.608517616722, 8804.955975220082, 8847.24798392144, 8892.8666070009, 4874.734607218684, 4894.779734911937, 4912.8771780705765, 5038.118329292359, 5041.0422019816115, 3593.083763640307, 3667.7065834733157, 3700.0934770980743, 3704.1850792825535, 3707.443883417509, 631.2834932351814, 662.5660192573775, 674.5278305186389, 677.2482544375739, 684.397729997599, 652.2271108736163, 716.4662326566742, 716.6631683108931, 754.4077898849487, 754.728297812787, 9970.950145249228, 10183.879773224939, 10248.282620216512, 10375.636852710119, 10492.370457772558, 619.6375120554436, 647.6243778608396, 676.8003438985511, 711.4664001998501, 744.8808190689464, 4875.926861097087, 5000.924986125211, 5006.123928312531, 5007.148784706608, 5028.34631497903, 120004.0, 122701.38649306697, 123507.38246308891, 124693.0, 124850.0, 63056.68471657612, 79610.20389796144, 98581.0, 101498.0, 101870.49064754778, 54565.0, 55797.44202557922, 80846.0, 87208.0, 88298.55850720833, 10216.868905527002, 10489.895101048893, 10501.9474902625, 10537.73655658584, 10656.89343106559, 49394.259086114456, 50460.49539504705, 50863.23705144352, 51261.74369128131, 52243.216351753996, 46978.76510617425, 47302.76348618373, 47674.76162619165, 69160.0, 72403.0, 12831.550895718605, 13084.934575327063, 13134.737305254033, 13318.933405332911, 13574.86425135736, 14563.271836408348, 14674.41302347894, 14978.176200309088, 15090.094594324375, 15920.0, 13956.651083722989, 14181.929090354482, 14511.564653060424, 14526.709465810412, 14964.326605302569, 13923.373448194652, 14218.573442796733, 14335.211563364115, 14381.568552943429, 14840.0, 13043.739125217633, 13145.014123940933, 13267.668308291984, 13298.078934002508, 13338.666533336744, 11494.82757758651, 11590.188686791844, 11622.476988535705, 11748.765024699629, 11874.346910919983, 11336.829947550628, 11345.319280842845, 11581.525542337096, 11634.12744044217, 11692.181547291608], "value": 7555.40862333644, "unit": "score"}], "name": "dromaeo_css", "value": 7133.024366875199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 109.0, 111.0, 110.0, 111.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 129.0, 180.0, 128.0, 130.0, 155.0, 125.0, 159.0, 126.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 131.0, 76.0, 76.0, 75.0, 74.0, 108.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 113.0, 87.0, 86.0, 86.0, 121.0, 86.0, 85.0, 122.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 54.0, 53.0, 52.0, 64.0, 54.0, 52.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 80.0, 81.0, 81.0, 81.0, 81.0, 110.0, 81.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 124.0, 122.0, 121.0, 129.0, 130.0, 124.0, 132.0, 127.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 169.0, 162.0, 162.0, 163.0, 164.0, 165.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1504.8, "alertThreshold": 2.0}]} 01:27:02 INFO - Return code: 0 01:27:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:27:02 INFO - # TBPL SUCCESS # 01:27:02 INFO - Running post-action listener: _resource_record_post_action 01:27:02 INFO - ##### 01:27:02 INFO - ##### Finished run-tests step (success) 01:27:02 INFO - ##### 01:27:02 INFO - Running post-run listener: _resource_record_post_run 01:27:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 552898560; Read time: 348; Write time: 442064 01:27:02 INFO - TinderboxPrint: CPU usage
13.3% 01:27:02 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 348 01:27:02 INFO - TinderboxPrint: I/O write bytes / time
552,898,560 / 442,064 01:27:02 INFO - TinderboxPrint: CPU idle
8,254.3 (86.7%) 01:27:02 INFO - TinderboxPrint: CPU user
1,218.9 (12.8%) 01:27:02 INFO - TinderboxPrint: Swap in / out
0 / 0 01:27:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256237568; Read time: 92; Write time: 228200 01:27:02 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 296660992; Read time: 256; Write time: 213864 01:27:03 INFO - Running post-run listener: _upload_blobber_files 01:27:03 INFO - Blob upload gear active. 01:27:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:27: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 01:27: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'] 01:27: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 01:27:03 INFO - (blobuploader) - INFO - Open directory for files ... 01:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:04 INFO - (blobuploader) - INFO - Done attempting. 01:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:04 INFO - (blobuploader) - INFO - Done attempting. 01:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:08 INFO - (blobuploader) - INFO - Done attempting. 01:27:08 INFO - (blobuploader) - INFO - Iteration through files over. 01:27:08 INFO - Return code: 0 01:27:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:27:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:27:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e72e1ac52b416b3166a20d4fdeb7267e6a86dbaaedea0903361e86669ccf936e580f6aced883fc2f3d2194776b0a7bc4e6d28912f9cadd215a1f99173ca534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe737f3ca173034bb313ca3538f2cf04a4e77f488818270b5cf83b292a7332b73a13a4ff42c24130baa3d560f774ef6559d9301649b40c88217955f6e5da2067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908a575b5b2db0756e9c2276b5b9fd3874604d59f0f8c195509c50d2c853588cc39991a88b41237df1c8a7af3644caa90c7b2bf3229820c50cb34acb40159c98"} 01:27:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:27:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:27:08 INFO - Contents: 01:27:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e72e1ac52b416b3166a20d4fdeb7267e6a86dbaaedea0903361e86669ccf936e580f6aced883fc2f3d2194776b0a7bc4e6d28912f9cadd215a1f99173ca534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe737f3ca173034bb313ca3538f2cf04a4e77f488818270b5cf83b292a7332b73a13a4ff42c24130baa3d560f774ef6559d9301649b40c88217955f6e5da2067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908a575b5b2db0756e9c2276b5b9fd3874604d59f0f8c195509c50d2c853588cc39991a88b41237df1c8a7af3644caa90c7b2bf3229820c50cb34acb40159c98"} 01:27:08 INFO - Running post-run listener: copy_logs_to_upload_dir 01:27:08 INFO - Copying logs to upload dir... 01:27:08 INFO - mkdir: /builds/slave/test/build/upload/logs 01:27:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.834483 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-18 01:27:07.597018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 01:27:07.600961) ========= 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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e72e1ac52b416b3166a20d4fdeb7267e6a86dbaaedea0903361e86669ccf936e580f6aced883fc2f3d2194776b0a7bc4e6d28912f9cadd215a1f99173ca534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe737f3ca173034bb313ca3538f2cf04a4e77f488818270b5cf83b292a7332b73a13a4ff42c24130baa3d560f774ef6559d9301649b40c88217955f6e5da2067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908a575b5b2db0756e9c2276b5b9fd3874604d59f0f8c195509c50d2c853588cc39991a88b41237df1c8a7af3644caa90c7b2bf3229820c50cb34acb40159c98"} build_url:https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/Vb16PveLR-eIPaGqPcrxsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e72e1ac52b416b3166a20d4fdeb7267e6a86dbaaedea0903361e86669ccf936e580f6aced883fc2f3d2194776b0a7bc4e6d28912f9cadd215a1f99173ca534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe737f3ca173034bb313ca3538f2cf04a4e77f488818270b5cf83b292a7332b73a13a4ff42c24130baa3d560f774ef6559d9301649b40c88217955f6e5da2067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908a575b5b2db0756e9c2276b5b9fd3874604d59f0f8c195509c50d2c853588cc39991a88b41237df1c8a7af3644caa90c7b2bf3229820c50cb34acb40159c98"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 01:27:07.626302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:27:07.626627) ========= 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=0333a256a5e4f052382dd180000001b1-1466227705.657737-2045837751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 01:27:07.708698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 01:27:07.709016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 01:27:07.709314) ========= ========= Total master_lag: 0.17 =========