builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1459941862.41 results: success (0) buildid: 20160406030021 builduid: 5b52b492f60b424c888f4b3a7c1d9beb revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.409078) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.409535) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.409837) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.436908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.437194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.453245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.453613) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.504147) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.504411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.504750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.505024) ========= 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 04:24:22-- 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% 230M=0s 2016-04-06 04:24:22 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.667728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.668011) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019022 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.718835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:22.719240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 04:24:22,880 truncating revision to first 12 chars 2016-04-06 04:24:22,880 Setting DEBUG logging. 2016-04-06 04:24:22,880 attempt 1/10 2016-04-06 04:24:22,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68c0b7d6f16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 04:24:23,305 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723728 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:23.455929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:23.456251) ========= echo 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8'] 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 program finished with exit code 0 elapsedTime=0.004732 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:23.509661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:23.509970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 04:24:23.522654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-06 04:24:23.523048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:23 INFO - MultiFileLogger online at 20160406 04:24:23 in /builds/slave/test 04:24:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:24:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:23 INFO - {'append_to_log': False, 04:24:23 INFO - 'base_work_dir': '/builds/slave/test', 04:24:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:24:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:23 INFO - 'branch': 'Firefox-Non-PGO', 04:24:23 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:23 INFO - 'config_files': ('talos/linux_config.py',), 04:24:23 INFO - 'default_actions': ('clobber', 04:24:23 INFO - 'read-buildbot-config', 04:24:23 INFO - 'download-and-extract', 04:24:23 INFO - 'populate-webroot', 04:24:23 INFO - 'create-virtualenv', 04:24:23 INFO - 'install', 04:24:23 INFO - 'run-tests'), 04:24:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:23 INFO - 'download_minidump_stackwalk': True, 04:24:23 INFO - 'download_symbols': 'ondemand', 04:24:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:23 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:23 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:23 INFO - 'installer_path': 'installer.exe', 04:24:23 INFO - 'log_level': 'info', 04:24:23 INFO - 'log_name': 'talos', 04:24:23 INFO - 'log_to_console': True, 04:24:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:23 INFO - 'opt_config_files': (), 04:24:23 INFO - 'pip_index': False, 04:24:23 INFO - 'sps_profile': False, 04:24:23 INFO - 'sps_profile_interval': 0, 04:24:23 INFO - 'suite': 'dromaeojs', 04:24:23 INFO - 'system_bits': '32', 04:24:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:23 INFO - 'title': 'talos-linux64-ix-011', 04:24:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:23 INFO - 'use_talos_json': True, 04:24:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:23 INFO - 'work_dir': 'build'} 04:24:23 INFO - ##### 04:24:23 INFO - ##### Running clobber step. 04:24:23 INFO - ##### 04:24:23 INFO - Running pre-action listener: _resource_record_pre_action 04:24:23 INFO - Running main action method: clobber 04:24:23 INFO - rmtree: /builds/slave/test/build 04:24:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:24 INFO - Running post-action listener: _resource_record_post_action 04:24:24 INFO - ##### 04:24:24 INFO - ##### Running read-buildbot-config step. 04:24:24 INFO - ##### 04:24:24 INFO - Running pre-action listener: _resource_record_pre_action 04:24:24 INFO - Running main action method: read_buildbot_config 04:24:24 INFO - Using buildbot properties: 04:24:24 INFO - { 04:24:24 INFO - "project": "", 04:24:24 INFO - "product": "firefox", 04:24:24 INFO - "script_repo_revision": "production", 04:24:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:24:24 INFO - "repository": "", 04:24:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:24:24 INFO - "buildid": "20160406030021", 04:24:24 INFO - "pgo_build": "False", 04:24:24 INFO - "basedir": "/builds/slave/test", 04:24:24 INFO - "buildnumber": 543, 04:24:24 INFO - "slavename": "talos-linux64-ix-011", 04:24:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:24:24 INFO - "platform": "ubuntu64_hw", 04:24:24 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:24:24 INFO - "branch": "mozilla-central", 04:24:24 INFO - "repo_path": "mozilla-central", 04:24:24 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:24:24 INFO - "stage_platform": "linux64", 04:24:24 INFO - "builduid": "5b52b492f60b424c888f4b3a7c1d9beb", 04:24:24 INFO - "slavebuilddir": "test" 04:24:24 INFO - } 04:24:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:24:24 INFO - Running post-action listener: _resource_record_post_action 04:24:24 INFO - ##### 04:24:24 INFO - ##### Running download-and-extract step. 04:24:24 INFO - ##### 04:24:24 INFO - Running pre-action listener: _resource_record_pre_action 04:24:24 INFO - Running main action method: download_and_extract 04:24:24 INFO - mkdir: /builds/slave/test/build/tests 04:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:24 INFO - https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:24:26 INFO - Downloaded 1361 bytes. 04:24:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:24:26 INFO - Using the following test package requirements: 04:24:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:24:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'jsshell-linux-x86_64.zip'], 04:24:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24: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')]} 04:24:26 INFO - https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:24:28 INFO - Downloaded 22129519 bytes. 04:24:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:24:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:24:29 INFO - Return code: 0 04:24:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:29 INFO - https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:24:31 INFO - Downloaded 22129519 bytes. 04:24:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:24:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:24:33 INFO - Return code: 0 04:24: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')]} 04:24:33 INFO - https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:24:34 INFO - Downloaded 10847617 bytes. 04:24:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:24:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:24:35 INFO - Return code: 0 04:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:35 INFO - https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:24:36 INFO - Downloaded 54188007 bytes. 04:24:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:24:36 INFO - mkdir: /builds/slave/test/properties 04:24:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:36 INFO - Contents: 04:24:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:24:37 INFO - Running post-action listener: _resource_record_post_action 04:24:37 INFO - Running post-action listener: set_extra_try_arguments 04:24:37 INFO - ##### 04:24:37 INFO - ##### Running populate-webroot step. 04:24:37 INFO - ##### 04:24:37 INFO - Running pre-action listener: _resource_record_pre_action 04:24:37 INFO - Running main action method: populate_webroot 04:24:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:37 INFO - '--tppagecycles', 04:24:37 INFO - '7'], 04:24:37 INFO - 'tests': ['tsvgm']}}, 04:24:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['damp', 'tps']}, 04:24:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'tests': ['damp', 'tps']}, 04:24:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['dromaeo_dom']}, 04:24:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['a11yr', 04:24:37 INFO - 'ts_paint', 04:24:37 INFO - 'tpaint', 04:24:37 INFO - 'sessionrestore', 04:24:37 INFO - 'sessionrestore_no_auto_restore', 04:24:37 INFO - 'tabpaint']}, 04:24:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['tsvgx', 04:24:37 INFO - 'tsvgr_opacity', 04:24:37 INFO - 'tart', 04:24:37 INFO - 'tscrollx', 04:24:37 INFO - 'cart']}, 04:24:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:37 INFO - 'tsvgr_opacity', 04:24:37 INFO - 'tart', 04:24:37 INFO - 'tscrollx', 04:24:37 INFO - 'cart']}, 04:24:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'talos_options': ['--disable-e10s'], 04:24:37 INFO - 'tests': ['tp5o']}, 04:24:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'tests': ['tp5o']}, 04:24:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'talos_options': ['--disable-e10s', 04:24:37 INFO - '--xperf_path', 04:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:37 INFO - 'tests': ['tp5n']}, 04:24:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:37 INFO - 'talos_options': ['--xperf_path', 04:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:37 INFO - 'tests': ['tp5n']}}, 04:24:37 INFO - 'talos.zip': {'path': '', 04:24:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:37 INFO - Running post-action listener: _resource_record_post_action 04:24:37 INFO - ##### 04:24:37 INFO - ##### Running create-virtualenv step. 04:24:37 INFO - ##### 04:24:37 INFO - Running pre-action listener: _resource_record_pre_action 04:24:37 INFO - Running main action method: create_virtualenv 04:24:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:24:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:37 INFO - Using real prefix '/usr' 04:24:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:40 INFO - Installing pip.................done. 04:24:40 INFO - Return code: 0 04:24:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:40 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 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:40 INFO - Using env: {'DISPLAY': ':0', 04:24:40 INFO - 'HOME': '/home/cltbld', 04:24:40 INFO - 'LANG': 'en_US.UTF-8', 04:24:40 INFO - 'LANGUAGE': 'en_US:en', 04:24:40 INFO - 'LOGNAME': 'cltbld', 04:24:40 INFO - 'MAIL': '/var/mail/cltbld', 04:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:40 INFO - 'MOZ_NO_REMOTE': '1', 04:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:40 INFO - 'NO_EM_RESTART': '1', 04:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:40 INFO - 'PWD': '/builds/slave/test', 04:24:40 INFO - 'SHELL': '/bin/bash', 04:24:40 INFO - 'SHLVL': '1', 04:24:40 INFO - 'TERM': 'linux', 04:24:40 INFO - 'TMOUT': '86400', 04:24:40 INFO - 'USER': 'cltbld', 04:24:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:40 INFO - '_': '/tools/buildbot/bin/python'} 04:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:24:40 INFO - Cleaning up... 04:24:40 INFO - Return code: 0 04:24:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:24:40 INFO - Using env: {'DISPLAY': ':0', 04:24:40 INFO - 'HOME': '/home/cltbld', 04:24:40 INFO - 'LANG': 'en_US.UTF-8', 04:24:40 INFO - 'LANGUAGE': 'en_US:en', 04:24:40 INFO - 'LOGNAME': 'cltbld', 04:24:40 INFO - 'MAIL': '/var/mail/cltbld', 04:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:40 INFO - 'MOZ_NO_REMOTE': '1', 04:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:40 INFO - 'NO_EM_RESTART': '1', 04:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:40 INFO - 'PWD': '/builds/slave/test', 04:24:40 INFO - 'SHELL': '/bin/bash', 04:24:40 INFO - 'SHLVL': '1', 04:24:40 INFO - 'TERM': 'linux', 04:24:40 INFO - 'TMOUT': '86400', 04:24:40 INFO - 'USER': 'cltbld', 04:24:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:40 INFO - '_': '/tools/buildbot/bin/python'} 04:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:40 INFO - Downloading/unpacking psutil>=0.7.1 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:42 INFO - Installing collected packages: psutil 04:24:42 INFO - Running setup.py install for psutil 04:24:42 INFO - building 'psutil._psutil_linux' extension 04:24:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:24:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:24:43 INFO - building 'psutil._psutil_posix' extension 04:24:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:24:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:43 INFO - Successfully installed psutil 04:24:43 INFO - Cleaning up... 04:24:43 INFO - Return code: 0 04:24:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:24:43 INFO - Using env: {'DISPLAY': ':0', 04:24:43 INFO - 'HOME': '/home/cltbld', 04:24:43 INFO - 'LANG': 'en_US.UTF-8', 04:24:43 INFO - 'LANGUAGE': 'en_US:en', 04:24:43 INFO - 'LOGNAME': 'cltbld', 04:24:43 INFO - 'MAIL': '/var/mail/cltbld', 04:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:43 INFO - 'MOZ_NO_REMOTE': '1', 04:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:43 INFO - 'NO_EM_RESTART': '1', 04:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:43 INFO - 'PWD': '/builds/slave/test', 04:24:43 INFO - 'SHELL': '/bin/bash', 04:24:43 INFO - 'SHLVL': '1', 04:24:43 INFO - 'TERM': 'linux', 04:24:43 INFO - 'TMOUT': '86400', 04:24:43 INFO - 'USER': 'cltbld', 04:24:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:43 INFO - '_': '/tools/buildbot/bin/python'} 04:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:24:46 INFO - Installing collected packages: mozsystemmonitor 04:24:46 INFO - Running setup.py install for mozsystemmonitor 04:24:46 INFO - Successfully installed mozsystemmonitor 04:24:46 INFO - Cleaning up... 04:24:46 INFO - Return code: 0 04:24:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:24:46 INFO - Using env: {'DISPLAY': ':0', 04:24:46 INFO - 'HOME': '/home/cltbld', 04:24:46 INFO - 'LANG': 'en_US.UTF-8', 04:24:46 INFO - 'LANGUAGE': 'en_US:en', 04:24:46 INFO - 'LOGNAME': 'cltbld', 04:24:46 INFO - 'MAIL': '/var/mail/cltbld', 04:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:46 INFO - 'MOZ_NO_REMOTE': '1', 04:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:46 INFO - 'NO_EM_RESTART': '1', 04:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:46 INFO - 'PWD': '/builds/slave/test', 04:24:46 INFO - 'SHELL': '/bin/bash', 04:24:46 INFO - 'SHLVL': '1', 04:24:46 INFO - 'TERM': 'linux', 04:24:46 INFO - 'TMOUT': '86400', 04:24:46 INFO - 'USER': 'cltbld', 04:24:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:46 INFO - '_': '/tools/buildbot/bin/python'} 04:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:49 INFO - Downloading docopt-0.6.1.tar.gz 04:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:49 INFO - Running setup.py install for blobuploader 04:24:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:49 INFO - Running setup.py install for requests 04:24:49 INFO - Running setup.py install for docopt 04:24:49 INFO - Successfully installed blobuploader requests docopt 04:24:49 INFO - Cleaning up... 04:24:49 INFO - Return code: 0 04:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:49 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 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:49 INFO - Using env: {'DISPLAY': ':0', 04:24:49 INFO - 'HOME': '/home/cltbld', 04:24:49 INFO - 'LANG': 'en_US.UTF-8', 04:24:49 INFO - 'LANGUAGE': 'en_US:en', 04:24:49 INFO - 'LOGNAME': 'cltbld', 04:24:49 INFO - 'MAIL': '/var/mail/cltbld', 04:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:49 INFO - 'MOZ_NO_REMOTE': '1', 04:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:49 INFO - 'NO_EM_RESTART': '1', 04:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:49 INFO - 'PWD': '/builds/slave/test', 04:24:49 INFO - 'SHELL': '/bin/bash', 04:24:49 INFO - 'SHLVL': '1', 04:24:49 INFO - 'TERM': 'linux', 04:24:49 INFO - 'TMOUT': '86400', 04:24:49 INFO - 'USER': 'cltbld', 04:24:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:49 INFO - '_': '/tools/buildbot/bin/python'} 04:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:50 INFO - Running setup.py (path:/tmp/pip-RS5S3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:50 INFO - Running setup.py (path:/tmp/pip-d0gh9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:50 INFO - Running setup.py (path:/tmp/pip-dR6fDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:50 INFO - Running setup.py (path:/tmp/pip-WvdGIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:50 INFO - Running setup.py (path:/tmp/pip-p4nWhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:50 INFO - Running setup.py (path:/tmp/pip-GpwMle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:50 INFO - Running setup.py (path:/tmp/pip-n_RhAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:50 INFO - Running setup.py (path:/tmp/pip-9yhIeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:50 INFO - Running setup.py (path:/tmp/pip-bBuhUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:50 INFO - Running setup.py (path:/tmp/pip-8TST23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:50 INFO - Running setup.py (path:/tmp/pip-y6V6ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:50 INFO - Running setup.py (path:/tmp/pip-_xOkoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:50 INFO - Running setup.py (path:/tmp/pip-dbw410-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:50 INFO - Running setup.py (path:/tmp/pip-_cQOyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:51 INFO - Running setup.py (path:/tmp/pip-64LF02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:51 INFO - Running setup.py (path:/tmp/pip-E7EvY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:51 INFO - Running setup.py (path:/tmp/pip-PYxqUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:51 INFO - Running setup.py install for manifestparser 04:24:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:51 INFO - Running setup.py install for mozcrash 04:24:51 INFO - Running setup.py install for mozdebug 04:24:51 INFO - Running setup.py install for mozdevice 04:24:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:51 INFO - Running setup.py install for mozfile 04:24:51 INFO - Running setup.py install for mozhttpd 04:24:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:51 INFO - Running setup.py install for mozinfo 04:24:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:51 INFO - Running setup.py install for mozInstall 04:24:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Running setup.py install for mozleak 04:24:52 INFO - Running setup.py install for mozlog 04:24:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Running setup.py install for moznetwork 04:24:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Running setup.py install for mozprocess 04:24:52 INFO - Running setup.py install for mozprofile 04:24:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Running setup.py install for mozrunner 04:24:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:52 INFO - Running setup.py install for mozscreenshot 04:24:52 INFO - Running setup.py install for moztest 04:24:52 INFO - Running setup.py install for mozversion 04:24:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:53 INFO - Cleaning up... 04:24:53 INFO - Return code: 0 04:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:53 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 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:53 INFO - Using env: {'DISPLAY': ':0', 04:24:53 INFO - 'HOME': '/home/cltbld', 04:24:53 INFO - 'LANG': 'en_US.UTF-8', 04:24:53 INFO - 'LANGUAGE': 'en_US:en', 04:24:53 INFO - 'LOGNAME': 'cltbld', 04:24:53 INFO - 'MAIL': '/var/mail/cltbld', 04:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:53 INFO - 'MOZ_NO_REMOTE': '1', 04:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:53 INFO - 'NO_EM_RESTART': '1', 04:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:53 INFO - 'PWD': '/builds/slave/test', 04:24:53 INFO - 'SHELL': '/bin/bash', 04:24:53 INFO - 'SHLVL': '1', 04:24:53 INFO - 'TERM': 'linux', 04:24:53 INFO - 'TMOUT': '86400', 04:24:53 INFO - 'USER': 'cltbld', 04:24:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:53 INFO - '_': '/tools/buildbot/bin/python'} 04:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:53 INFO - Running setup.py (path:/tmp/pip-2gDquv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:53 INFO - Running setup.py (path:/tmp/pip-9Y88mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:53 INFO - Running setup.py (path:/tmp/pip-i60vMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:53 INFO - Running setup.py (path:/tmp/pip-vQJv6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:53 INFO - Running setup.py (path:/tmp/pip-k2W4sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:53 INFO - Running setup.py (path:/tmp/pip-EhGlgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:53 INFO - Running setup.py (path:/tmp/pip-ebVD5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:53 INFO - Running setup.py (path:/tmp/pip-ZX4dJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:53 INFO - Running setup.py (path:/tmp/pip-Jl2Nsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:53 INFO - Running setup.py (path:/tmp/pip-DG1mQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:53 INFO - Running setup.py (path:/tmp/pip-4zQiPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:54 INFO - Running setup.py (path:/tmp/pip-0MUHaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:54 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)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:54 INFO - Running setup.py (path:/tmp/pip-EBET_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:54 INFO - Running setup.py (path:/tmp/pip-dNhn0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:54 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)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:54 INFO - Running setup.py (path:/tmp/pip-GKqB9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:54 INFO - Running setup.py (path:/tmp/pip-NelJzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:54 INFO - Running setup.py (path:/tmp/pip-1IZxPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:56 INFO - Downloading blessings-1.6.tar.gz 04:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:56 INFO - Installing collected packages: blessings 04:24:56 INFO - Running setup.py install for blessings 04:24:56 INFO - Successfully installed blessings 04:24:56 INFO - Cleaning up... 04:24:56 INFO - Return code: 0 04:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:57 INFO - Reading from file tmpfile_stdout 04:24:57 INFO - Current package versions: 04:24:57 INFO - argparse == 1.2.1 04:24:57 INFO - blessings == 1.6 04:24:57 INFO - blobuploader == 1.2.4 04:24:57 INFO - docopt == 0.6.1 04:24:57 INFO - manifestparser == 1.1 04:24:57 INFO - mozInstall == 1.12 04:24:57 INFO - mozcrash == 0.17 04:24:57 INFO - mozdebug == 0.1 04:24:57 INFO - mozdevice == 0.48 04:24:57 INFO - mozfile == 1.2 04:24:57 INFO - mozhttpd == 0.7 04:24:57 INFO - mozinfo == 0.9 04:24:57 INFO - mozleak == 0.1 04:24:57 INFO - mozlog == 3.1 04:24:57 INFO - moznetwork == 0.27 04:24:57 INFO - mozprocess == 0.22 04:24:57 INFO - mozprofile == 0.28 04:24:57 INFO - mozrunner == 6.11 04:24:57 INFO - mozscreenshot == 0.1 04:24:57 INFO - mozsystemmonitor == 0.0 04:24:57 INFO - moztest == 0.7 04:24:57 INFO - mozversion == 1.4 04:24:57 INFO - psutil == 3.1.1 04:24:57 INFO - requests == 1.2.3 04:24:57 INFO - wsgiref == 0.1.2 04:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 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 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:57 INFO - Using env: {'DISPLAY': ':0', 04:24:57 INFO - 'HOME': '/home/cltbld', 04:24:57 INFO - 'LANG': 'en_US.UTF-8', 04:24:57 INFO - 'LANGUAGE': 'en_US:en', 04:24:57 INFO - 'LOGNAME': 'cltbld', 04:24:57 INFO - 'MAIL': '/var/mail/cltbld', 04:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:57 INFO - 'MOZ_NO_REMOTE': '1', 04:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:57 INFO - 'NO_EM_RESTART': '1', 04:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:57 INFO - 'PWD': '/builds/slave/test', 04:24:57 INFO - 'SHELL': '/bin/bash', 04:24:57 INFO - 'SHLVL': '1', 04:24:57 INFO - 'TERM': 'linux', 04:24:57 INFO - 'TMOUT': '86400', 04:24:57 INFO - 'USER': 'cltbld', 04:24:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:57 INFO - '_': '/tools/buildbot/bin/python'} 04:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:57 INFO - Cleaning up... 04:24:57 INFO - Return code: 0 04:24:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:24:57 INFO - Using env: {'DISPLAY': ':0', 04:24:57 INFO - 'HOME': '/home/cltbld', 04:24:57 INFO - 'LANG': 'en_US.UTF-8', 04:24:57 INFO - 'LANGUAGE': 'en_US:en', 04:24:57 INFO - 'LOGNAME': 'cltbld', 04:24:57 INFO - 'MAIL': '/var/mail/cltbld', 04:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:57 INFO - 'MOZ_NO_REMOTE': '1', 04:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:57 INFO - 'NO_EM_RESTART': '1', 04:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:57 INFO - 'PWD': '/builds/slave/test', 04:24:57 INFO - 'SHELL': '/bin/bash', 04:24:57 INFO - 'SHLVL': '1', 04:24:57 INFO - 'TERM': 'linux', 04:24:57 INFO - 'TMOUT': '86400', 04:24:57 INFO - 'USER': 'cltbld', 04:24:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:57 INFO - '_': '/tools/buildbot/bin/python'} 04:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:57 INFO - Downloading/unpacking jsonschema 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:59 INFO - Downloading/unpacking functools32 (from jsonschema) 04:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:00 INFO - warning: no files found matching '*.txt' 04:25:00 INFO - no previously-included directories found matching 'build' 04:25:00 INFO - no previously-included directories found matching 'dist' 04:25:00 INFO - no previously-included directories found matching '.git*' 04:25:00 INFO - Installing collected packages: jsonschema, functools32 04:25:00 INFO - Running setup.py install for functools32 04:25:00 INFO - warning: no files found matching '*.txt' 04:25:00 INFO - no previously-included directories found matching 'build' 04:25:00 INFO - no previously-included directories found matching 'dist' 04:25:00 INFO - no previously-included directories found matching '.git*' 04:25:00 INFO - Successfully installed jsonschema functools32 04:25:00 INFO - Cleaning up... 04:25:00 INFO - Return code: 0 04:25:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd04294bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11855a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:25:00 INFO - Using env: {'DISPLAY': ':0', 04:25:00 INFO - 'HOME': '/home/cltbld', 04:25:00 INFO - 'LANG': 'en_US.UTF-8', 04:25:00 INFO - 'LANGUAGE': 'en_US:en', 04:25:00 INFO - 'LOGNAME': 'cltbld', 04:25:00 INFO - 'MAIL': '/var/mail/cltbld', 04:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:00 INFO - 'MOZ_NO_REMOTE': '1', 04:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:00 INFO - 'NO_EM_RESTART': '1', 04:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:00 INFO - 'PWD': '/builds/slave/test', 04:25:00 INFO - 'SHELL': '/bin/bash', 04:25:00 INFO - 'SHLVL': '1', 04:25:00 INFO - 'TERM': 'linux', 04:25:00 INFO - 'TMOUT': '86400', 04:25:00 INFO - 'USER': 'cltbld', 04:25:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:00 INFO - '_': '/tools/buildbot/bin/python'} 04:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:00 INFO - Downloading/unpacking flake8 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:04 INFO - no previously-included directories found matching 'docs/_build' 04:25:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:04 INFO - Running setup.py install for pep8 04:25:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:04 INFO - no previously-included directories found matching 'docs/_build' 04:25:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:04 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Running post-action listener: _resource_record_post_action 04:25:05 INFO - Running post-action listener: _start_resource_monitoring 04:25:05 INFO - Starting resource monitoring. 04:25:05 INFO - ##### 04:25:05 INFO - ##### Running install step. 04:25:05 INFO - ##### 04:25:05 INFO - Running pre-action listener: _resource_record_pre_action 04:25:05 INFO - Running main action method: install 04:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:05 INFO - Reading from file tmpfile_stdout 04:25:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:05 INFO - Reading from file tmpfile_stdout 04:25:05 INFO - Output received: 04:25:05 INFO - Usage: mozinstall [options] installer 04:25:05 INFO - Options: 04:25:05 INFO - -h, --help show this help message and exit 04:25:05 INFO - -d DEST, --destination=DEST 04:25:05 INFO - Directory to install application into. [default: 04:25:05 INFO - "/builds/slave/test"] 04:25:05 INFO - --app=APP Application being installed. [default: firefox] 04:25:05 INFO - mkdir: /builds/slave/test/build/application 04:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:25:21 INFO - Reading from file tmpfile_stdout 04:25:21 INFO - Output received: 04:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:21 INFO - Running post-action listener: _resource_record_post_action 04:25:21 INFO - ##### 04:25:21 INFO - ##### Running run-tests step. 04:25:21 INFO - ##### 04:25:21 INFO - Running pre-action listener: _resource_record_pre_action 04:25:21 INFO - Running main action method: run_tests 04:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:21 INFO - Python 2.7.3 04:25:21 INFO - Return code: 0 04:25:21 INFO - grabbing minidump binary from tooltool 04:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:21 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1214410>, '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 0x1215310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12157a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:21 INFO - Return code: 0 04:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:22 INFO - Return code: 0 04:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 04:25:22 INFO - Using env: {'DISPLAY': ':0', 04:25:22 INFO - 'HOME': '/home/cltbld', 04:25:22 INFO - 'LANG': 'en_US.UTF-8', 04:25:22 INFO - 'LANGUAGE': 'en_US:en', 04:25:22 INFO - 'LOGNAME': 'cltbld', 04:25:22 INFO - 'MAIL': '/var/mail/cltbld', 04:25:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:22 INFO - 'MOZ_NO_REMOTE': '1', 04:25:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:22 INFO - 'NO_EM_RESTART': '1', 04:25:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:22 INFO - 'PWD': '/builds/slave/test', 04:25:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:22 INFO - 'SHELL': '/bin/bash', 04:25:22 INFO - 'SHLVL': '1', 04:25:22 INFO - 'TERM': 'linux', 04:25:22 INFO - 'TMOUT': '86400', 04:25:22 INFO - 'USER': 'cltbld', 04:25:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705', 04:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:22 INFO - '_': '/tools/buildbot/bin/python'} 04:25:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:25:22 INFO - mozversion application_buildid: 20160406030021 04:25:22 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:25:22 INFO - mozversion application_display_name: Nightly 04:25:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:22 INFO - mozversion application_name: Firefox 04:25:22 INFO - mozversion application_remotingname: firefox 04:25:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:25:22 INFO - mozversion application_vendor: Mozilla 04:25:22 INFO - mozversion application_version: 48.0a1 04:25:22 INFO - mozversion platform_buildid: 20160406030021 04:25:22 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:25:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:25:22 INFO - mozversion platform_version: 48.0a1 04:25:22 INFO - using testdate: 1459941922 04:25:22 INFO - actual date: 1459941922 04:25:22 INFO - starting webserver on 'localhost:57359' 04:25:22 INFO - SUITE-START | Running 2 tests 04:25:22 INFO - TEST-START | dromaeo_css 04:25:22 INFO - operating with platform_type : linux_ 04:25:22 INFO - Initialising browser for dromaeo_css test... 04:25:22 INFO - TEST-INFO | started process 7908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZI5B0/profile http://localhost:57359/getInfo.html) 04:25:28 INFO - PROCESS | 7908 | __metrics Screen width/height:1600/1200 04:25:28 INFO - PROCESS | 7908 | colorDepth:24 04:25:28 INFO - PROCESS | 7908 | Browser inner width/height: 1024/697 04:25:28 INFO - PROCESS | 7908 | __metrics 04:25:29 ERROR - PROCESS | 7908 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:25:30 INFO - TEST-INFO | 7908: exit 0 04:25:30 INFO - Browser initialized. 04:25:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:30 INFO - TEST-INFO | started process 7992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZI5B0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:42 INFO - PROCESS | 7992 | RSS: Main: 154066944 04:25:42 INFO - PROCESS | 7992 | 04:26:33 INFO - PROCESS | 7992 | 1459941993750 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:28:45 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57359/tests/dromaeo/cssquery-ext.html) 04:28:46 INFO - PROCESS | 7992 | RSS: Main: 230719488 04:28:46 INFO - PROCESS | 7992 | 04:31:48 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-ext.html (next: http://localhost:57359/tests/dromaeo/cssquery-jquery.html) 04:31:49 INFO - PROCESS | 7992 | RSS: Main: 228892672 04:31:49 INFO - PROCESS | 7992 | 04:34:51 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57359/tests/dromaeo/cssquery-mootools.html) 04:34:51 INFO - PROCESS | 7992 | RSS: Main: 234078208 04:34:51 INFO - PROCESS | 7992 | 04:37:53 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57359/tests/dromaeo/cssquery-prototype.html) 04:37:54 INFO - PROCESS | 7992 | RSS: Main: 210763776 04:37:54 INFO - PROCESS | 7992 | 04:40:56 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57359/tests/dromaeo/cssquery-yui.html) 04:40:57 INFO - PROCESS | 7992 | RSS: Main: 204419072 04:40:57 INFO - PROCESS | 7992 | 04:43:59 INFO - PROCESS | 7992 | Cycle 1(1): loaded http://localhost:57359/tests/dromaeo/cssquery-yui.html (next: http://localhost:57359/tests/dromaeo/cssquery-dojo.html) 04:44:00 INFO - PROCESS | 7992 | RSS: Main: 251670528 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | __start_tp_report 04:44:00 INFO - PROCESS | 7992 | _x_x_mozilla_page_load 04:44:00 INFO - PROCESS | 7992 | _x_x_mozilla_page_load_details 04:44:00 INFO - PROCESS | 7992 | |i|pagename|runs| 04:44:00 INFO - PROCESS | 7992 | |0;dojo.html;2669.1725565074826;2741.6435863337765;2743.1084897408336;2758.544840101383;2767.8339299642016;4622.722636641804;4697.882552936178;4758.857234282973;4760.095581839448;4767.380240568726;4705.270683044134;4733.195356789345;4746.382970213867;4821.927671084928;4826.3725715657;4309.224339618867;4321.222180007598;4349.325854492558;4371.868843934687;4541.409616749818;4463.977680111595;4486.484054333744;4494.101179764044;4497;4546.795394207269;4297.269464191095;4341.196878577473;4400.977995110036;4425.645948324126;4439.88900277494;4368.453943257093;4368.737875727435;4408.58118478744;4411.2941929291155;4435.3125265583885;4352.477702675699;4354.7604881731495;4371.2568863293;4393.275109606943;4410.669199809995;4509.301058335963;4626.236670949289;4656.068786242731;4656.65075119364;4722.7402492862875;5092.337996060489;5100;5106.234064890296;5106.4893510648635;5140.306058682105;5105.642605017651;5117.283580298761;5121.871953201163;5122.615803814691;5166.612504062173;4705.670603057822;4759.6668233223345;4771.475137734881;4842.297866809293;4854.320395144682;5260.736963151827;5263.842084737464;5266.34170728659;5296.364436267672;5300.31095957523;5021.5229553192385;5029.673071250357;5032.245163225545;5033.018561380496;5082.74586270685;5035.043341765053;5057.544820966131;5106.131957567222;5121.308623335876;5121.4622464641425;5076.6192535559985;5081.28861959326;5083.059633967728;5084.161113416319;5107.310513080761;5044.117279476077;5046.84859454217;5048.924266136011;5054.115529782347;5090;4164.7709375984;4255.851045213402;4256.233877902007;4260.190563792869;4334;3767.7550959187565;3832.7125465590193;3842.9039274018373;3851.1912498375655;3851.5763266040713;4377.846775362847;4435.290353543418;4448.5773851484055;4451.043025749479;4456.309272062836;5123.897522049539;5127.9230811537855;5151.484851514819;5173.715445650525;5177.404598471148;4420.31485119807;4422.469303683514;4422.668299877522;4428.734275943454;4468.731876087445;4515.841945531956;4541.364209010741;4582.587567118975;4587.495375508692;4623.69945953512;4877.926831097466;4877.95122048775;4879.39007624047;4888.584470320063;4931.802727890844;5082.593392528663;5139.897202055863;5152.098382783073;5152.252923326022;5155.587552995827;4823.782929768098;4836.492168322276;4863.95136048635;4893.632977526629;4926.261060840902;5005.899882002413;5028.195488721787;5041.521055499722;5054.241863720325;5064.240363945438;5128.948710512847;5129.974350128375;5130.076586214517;5132.692038477703;5163.8192663256605;4833.41998960113;4963.255511673278;4988.176950803077;5073.518015788494;5090.211017292326;4921.975390123026;4924.212126059813;4940.802367905388;4942.604591632589;4981.900361992813;4864.756762161948;4864.951350486592;4866.099771542276;4866.221404575251;4917.188663870421;4887.486813884633;4969.975150124226;5019;5023.146065169003;5064.44291127983;4846.151923413459;4876.244182151772;4884.242942343943;4885.511448855086;4928.06366790323 04:44:00 INFO - PROCESS | 7992 | |1;ext.html;528.8862894477687;539.3366159623663;542.4900593442167;553.6124712701109;586.0974099886175;27381.178564643044;34464.31071378571;35038.12404689884;35043.123921901904;35139;38200;38636.80681596588;38637;38674.806625966834;38698.80650596743;7633.160352361236;7830.882536761953;7833.764987050397;7834.255745704178;7837.0987336456465;7759.107702614215;7893.605319734019;7894.842103157934;7895.644695988665;8030.196980301981;8023.919760802376;8087.878681819778;8090.433669643127;8092.2716955474;8092.2716955474;7989.800254993643;8054.718084867001;8059.5164290142775;8063.758087257363;8065.596720163969;7951.244631759973;8072.798180045487;8076.111627720946;8076.313513351372;8077.192280771935;38425.615743842485;38888.80555597232;38908.22183556313;38925.610743892765;38931.61068389336;3050.2679356954395;3094.241910731885;3108.1918701137865;3254.30032543002;3345.3476572068457;28816.567751483744;29469.557956630666;29493.70506294931;29559;29685.885718827005;3362;3373.797572145679;3377.240120972786;3446.7547272682414;3509.280597477511;225664;227702;228873;229415;229572;56572.71713641405;56780.148297775566;56881.71559142178;56928.71535642295;57054.71472642693;52934.73532632312;60115.39884601098;62491;63461.36538634647;63575.68212159002;14304.785428218585;14558.636034099232;14652.267386630625;14653.706925861636;14671.77992330116;10769.62306319275;10773.084287835465;10831.729206769895;10836.783264334668;10852.348859068481;17435.47693569195;17910.194041268172;19921.701174482394;20495.28266510665;20495.590088198154;7411.2588741125455;7439.404847612178;7585.848283034308;7662.731804386931;7678.308952194217;900.1358695652116;907.577976241051;1001.7195185348114;1020.4438580973388;1027.8972102789662;27445.725542744716;27522.311942201606;27937.720622793917;28227.57658635122;28381.858090709826;988.7033889833021;997.448966856545;1013.224882964518;1026.4559783314855;1082.8105081610686;14381.78427323591;14596.635084122981;14724.631884202981;14788.482403116055;14948;267576;269218;271593;271969;272412;47526.52473475221;48547.75726121347;48590.27114593284;48591.757041214565;48647.75676121597;1157.988420115805;1196.0969468051564;1241.6647505173732;1256.3466997161424;1266.9303188324732;24359.878200608884;24658.506829862945;25217.49565008726;25296;25602.487950241262;35177.47233791546;35305;35493.82253088718;35496;35530.467042993856;161747.19126404292;165813;174036;174123;174292;29149.7085029147;29965.400691986473;30408.5438718415;30491.695083048886;30495.390092198475;38469.6153038466;38721.41917871178;39054.6094539051;39401.211975760896;39542.40686389764;32252.354952900343;32597.511037334934;33243.335133296714;33726.156846079044;33742.78570114872;32283.838580806947;32295.192620183745;32597.837010814794;32816.835915821226;33242.501362479095;33143.50284745779;33417.16457088495;33486.162845929044;34773.47839782456;35477.93566193018;27324.497152656;28358.71641283561;28821;28889;29101;22617.11318960053;24179.51640967206;24500.509989799746;24644.260672179862;24698.259052228463 04:44:00 INFO - PROCESS | 7992 | |2;jquery.html;337.1537441023032;344.3783969934271;346.8283199816091;350.1194495842954;350.4900369961706;15622.609434764137;16135.11256880871;16289.26698298575;17205.569860753487;17674.116294185304;16329.304305679798;16680.83319166808;16692.74960875588;16826.07456589887;16843.57891052724;4910.582600478954;5052.4947505249365;5083.84748457545;5098.311727916739;5099.745012749367;5157.6131790115705;5168.974155129219;5190.844274671747;5200.427952925175;5201.713905735183;5157.7936882524655;5172.379314482268;5174.068667639824;5175.974120129394;5176.016556854186;5674.858128546778;5678.3186017678145;5745.253117094772;5774.884502309972;5870.559708021916;5181.4300426953005;5199.1161502544655;5265.210218467222;5272.182811664198;5274.683518988873;18196.72704909414;18243.45269641913;18771.624567508574;18786.060696965233;18812.153453094645;1927.8650494465394;1954.3452943264024;2026.1490174126902;2074.730285062947;2206.437358473595;9171.082891710843;9294.581743821544;9385.812283754287;9424.528773561295;9811.803763924681;1698.2188193431036;1715.7254839225789;1739.1391261325725;1813.4831573001632;1826.0960824391877;55826.720866395815;57494.42505574933;59374;60142.39857601455;61698.38301616971;8839.674048892717;9205.677801277057;9439.339246252697;9808.215342772704;9886.110250077527;13196.868031319564;13212.405441755143;13281.867181328063;13294.534691285759;13298.534551290659;6864.553804002724;6929.826754331081;6980.336867997532;7140.892886606705;7282.635868206675;6505.381988711065;6512.413882750575;6605.900911486331;6761.087253220752;6937.618430986243;4205.852795152155;4210.831566737357;4244.578066347808;4246.171996460722;4264.957350426518;1723.4743403262125;1746.6855965926002;1764.2237415537122;1767.6553072151064;1836.3205613922667;831.1461067366608;845.446232717571;876.8816209811721;879.784452809053;950.8954015058338;15590.532284031497;15959;16023.919880400523;16060.43788467398;16570;832.4464231286248;840.3487297344485;867.4665080975154;880.5157163560017;896.171041786345;9016.413933094327;9283.76790580241;9363.34456588046;9390.765230869147;9536;354407;372770;398303;399463;400969;55341.723291383285;69657;69861.3013869865;70290;72363.63818180875;905.9547022648973;907.2424525521131;928.5728564860104;929.0430856218106;947.5309721687809;15077.849221508084;15398.384064637288;15409.383624654889;15537.84462155364;15772.68454630924;34021.829890851375;34183.658163419044;34221;34346;34616.48075278923;45834;47349.763251183525;47388.52611473841;47513;47900.7604961973;7397.112346518452;7464.738734144279;7503.161725377317;7538.736144234926;7598.430117741302;8593.914060859312;11884.108691847972;11953.22304050234;11977.461014254553;12009.159358844798;9837.360571562825;9983;10259.230557708352;10331.121854642439;10423.739406514898;9431.339806213498;10230.23273254494;10455.215858810467;10458.372497650165;10677.786444271227;10634.627788027381;10960.780784384428;11058.115350771757;11130.610428634958;11445.828312575151;7380.520266182895;7504.249575042452;7517;7576.1287451941525;7628.0464941882265;9485.857712134186;10455.320404173704;10589.841152382874;10687.091597214323;10753.784924301626 04:44:00 INFO - PROCESS | 7992 | |3;mootools.html;1411.9929400352996;1420.3040510150026;1542.9382824687013;1748.2832038864053;1779.7775278090246;7356.4114870810345;7533.246675332464;7561.054868141482;7575.810604734885;7577.621118944045;6528.053432252321;7083.64581770912;7242.6016569088815;7266.491345605809;7432.479726419153;2237.2393386248673;2255.458689914417;2260.457490202356;2262.2873794754682;2262.309995451387;1914.3204162522313;2215.523662412581;2241.3500084975417;2260.0846657103816;2264.094362255095;2206.249875042485;2263.7057182566246;2264.286749673856;2265.546890621874;2273.5111950930545;2224.721909761288;2245.6856040154394;2252.087904398721;2266.1275408967504;2271.8523295985706;2192.473806286496;2195.1438938813876;2201.7908298711595;2208.514126892081;2209.767974362685;7611.276928691821;7663.846723065563;7670.232976702341;7848.803779905491;7850.214978502161;4648.418947631546;4728.692634978715;4746.715197088186;4760.714357138583;4760.785764640599;2896.6379202599674;2921.2550799546193;2980.2698338907107;2982.7166419190144;2991.1774262077884;897.3180382908971;898.532762963262;919.5080631861989;935.8315503209419;970.1947383671536;10657.094146997515;10678.51946662402;10679.679609611647;10683.198760092946;10722;4240.173166232555;4337.240982827992;4357.934630980538;4390.4511936008;4394.824207031683;9056.547172641342;9081.54592270384;9091.090890910857;9094.681686140953;9101.453912765122;4748.216544270226;4757.571818536279;4790.730456429049;4792.161371759928;4798.04039192156;4250.086231460251;4290.82836686529;4294.76378799169;4301.505326887448;4309.353596960418;3478.926015937385;3652.8356223969986;3681.5214022176947;3692.9076773080888;3697.2975134724315;1055.6041484443333;1135.335828540313;1165.056304393444;1174.213277104342;1174.5008371442102;1192.3322939154102;1200.327816422806;1219.810929305959;1237.641084085623;1243.4777393494753;6974.232834388214;7044.049053377831;7056.858862822714;7080.079589653312;7264.273572642799;1051.0803047333584;1052.3843551522446;1059.6609085092696;1077.488193108283;1090.1061129873585;5513.5037846593195;5548.5838562108;5553.916691249635;5635.549156067505;5641.548676105902;9039.141281578239;9347.672831450867;9399.671011514563;9407.952960235156;9431.858522122173;9166.954165229132;9421.76445588852;9511.952440237754;9533.570989305359;9543.093406126407;6982.546134501241;7154.821129471805;7184.604846733584;7188.209296977328;7194.676239569232;7084.185318688416;7139.643017848983;7159.677814498256;7226.385757210696;7242.927570724225;8054.395920306118;8195.631196596287;8248.257656810916;8304;8415.158484151782;8493.660253590035;8515.233628973423;8545.786355340917;8643.092475290256;8654.264387526879;6675.899861502178;6753.831154221184;6807.863842723019;6825.965870170618;6834.829129271808;6999.510034297754;7061.752838650623;7081.291870813084;7081.610511421715;7092.751753688596;5448.427915068861;6489.221293444817;6683.164604424447;6716.1604799400075;6858.348456896587;6203.16257305258;6213.316535181217;6234.096056071753;6262.812115636538;6303.684815759286;6559.868802623825;6595.835104122435;6615.140031795836;6622.602643841385;6623.768168114093;6216.7824126155365;6335.968320158369;6342.175517182736;6344.111824344688;6362.172917520693;6415.166028416276;6448.193975753031;6461.483081353575;6466.870662586628;6503.739850405931 04:44:00 INFO - PROCESS | 7992 | |4;prototype.html;307.66618219232134;312.85764976935496;313.88856955780705;315.4889079690901;316.21263054993045;5298.973505132474;5311.628186026975;5366.4633536646415;5375.193720941861;5380.24676545283;5270.762815673294;5287.048331300364;5339.5728341732665;5343.492368225022;5368;3986.2027594481074;4071.1043570414463;4158.168366326747;4171.874843754692;4179.080602267496;4157;4158.022864626811;4191.329387298033;4201.684873634475;4202.621764041236;4154.127633197032;4156.521999970012;4156.667466602665;4159.064210552617;4161.979190104045;3938.6061393860673;4038.6567141792984;4163.562825903282;4167.854125105637;4174.31123864562;3672.889813305605;3684.7236457265544;3698.7780733156096;3699.6855267302312;3701.0747313171705;5145.305383773218;5147.536721695065;5158.871028224287;5160.638755287131;5163.66436181647;4844.806207751686;4848.29699693546;4853.39332583427;4857.028594281122;4868.561829435368;5684.403137670526;5689.544836413077;5692.37383887772;5693.430656934273;5696.487316141567;4070.1249231415386;4072.287349713818;4075.7554546727292;4076.653484453825;4086.5504794472586;5688.943110568883;5921.792737254218;5938.910916336258;5949;5953.8809223815715;4136.152088821785;4143.233501802116;4153.979230103831;4159.750414975111;4178.498580170399;4212.473440819897;4213.6839737019845;4219.07180420307;4227.7528129201955;4234.06850492891;4793.736344501086;4795.136875362398;4796.736179510161;4803.3995750531185;4804.399450068741;5653.067243904709;5655.80204692842;5662.5753068520025;5663.490285874291;5669.376368599451;1467.4790449390525;1491.1873029199112;1496.0350573879787;1496.6931778985281;1497.423491955605;934.9532523373804;975.5658731864253;1010.3331801011298;1012.3875055591409;1019.4189312092185;4919.1391506486225;4996.100701873697;5011.699298042129;5032.647714660012;5038.697678139323;5838.357780644125;5864.530837532987;5872.911906321408;5875.941240587625;5879;4959.479254678206;5000.724960127228;5005.5745261653165;5044.823431179964;5056.9494305057215;3144.5283207519055;3179.8251096189933;3181.0933883843454;3185.442547554169;3187.9840600796847;5604.159376093618;5608.10270356741;5608.887822243532;5614.29821272341;5614.494695477427;5838.883222335529;6058.273007239071;6060.212172417558;6066.48434883031;6068.696565171724;5554.0835762099605;5574.386817450078;5579.972100139555;5586.748596313176;5594.944050559605;5915.526757859275;5917.378675239038;5918.615290006136;5922.289325280994;5926.67403292823;5774.220480235114;5775.364709881994;5786.247787787561;5786.826395208151;5788.82633520995;5427.674339539641;5584.776608935759;5596.524295434933;5597.3003374578175;5602.691851948182;4179.665626749914;4196.8111434984885;4199.370094485852;4202.432671589297;4208.116295577841;5862.501687356452;5880.353161152356;5886.529077673861;5894.204282421818;5894.20428242199;5643.407442218508;5680.289963754531;5697.3448053474385;5699.2590963174525;5708.086706127166;5692.857678558069;5696.772129114789;5697.116946873241;5700.144978253295;5707.571932105192;5474.1827192072315;5552.750126244248;5618.719064046863;5620.85947851307;5622.32532096151;5712.971665100322;5735;5740.0815869460685;5741.569382296261;5746.109353050284;5595.972020139873;5597.5521958242425;5603.8318850432925;5604.8879022418505;5610.5231055360755 04:44:00 INFO - PROCESS | 7992 | |5;yui.html;688.390774164864;688.4698781937911;697.3863000559509;697.6511744127936;706.7349743846057;10863.45682715863;10876.184286178539;10912.945435272832;10915.454227288634;10982.615608453705;11156.219064665476;11202.551897924073;11262.774744505105;11265;11282.266652667591;637.8915584350648;769.1769806307253;786.3709032773787;805.7582725182451;819.9139090395512;814;817.6565842346229;820.2412768189431;821.0188824354898;821.1255013410728;861.8362511122898;864.7016779211193;866.5580553917484;868.5961028121922;869.0310304011014;676.8003438985511;834.9540775257389;853.8121613245077;854.2482615298528;855.0252711908367;625.1185827982523;626.8182227154119;627.0187157099125;627.3600927054379;627.4823270801606;11659.941700291443;11742.882571174265;11771.882281177164;11774.94112529432;11786.705332366673;11853.348065856375;12308.07689423288;12381.071419643473;12575.685607859785;12762.68093297675;9956.900430995669;10016.298859079867;10140.340877842917;10151.543180556819;10232.181425486018;3270.2314955985325;3312.9006129815903;3316.5025246213263;3336.382769187708;3362.3107263011025;44935.550644493465;44950.775246123885;45004.324935126;45031;45062.54937450616;9142.222911052502;9670;9682.806343873082;9698.903010969942;9782;17588.296468141132;17616.471505854846;17648.294068237126;17678.823211767718;17704.557386065193;6344.524160687874;6549.705263263165;6550.934490655128;6608.43828274602;6697.162854643169;3615.07815507044;3635.381985062546;3725.8137093145233;3747.8126093695205;3762.793046382475;2797.8321300722023;2818.450402171598;2818.873150708223;2837.9148625541266;2837.929051773722;456.8149899290793;465.2393336894202;480.73319307784516;484.39934481243006;486.2730218323629;558.4694540186839;604.4559896093463;604.6160687963174;612.3967891626744;647.6211416321411;7375.594342311224;7493.175750667422;7606.201348858401;7739.961300193576;7848.960755196302;541.8753686652013;544.9427810079964;546.6965833962189;557.0557904352085;566.2582017557013;3498.2129020970588;3549.698275646599;3573.8391772370305;3653.7990410527677;3669.614690457517;49711.75144124256;49955;50030.74984625127;50203.74898125486;50812.49187508078;45341.31988020182;45424;45519.77240113778;45955.5404445958;46206.07587848224;40972.385414218814;41469.585304146574;42112;42187.36718949157;42203.788981054895;8218.383621228551;8256.669733210605;8263.710770123016;8384.916150838413;8404.32765378756;30541.694583053886;30765.538516921817;31047.68952310448;31265.090292327102;31762.205944851565;36749.63250367462;36753;37806.81096594499;40793.79603101966;41024.589754102075;9206.29683508553;9327.906720932704;10109.14072303833;10190.133838623504;10362.637307694195;11281.379524126252;11293.71765705864;11487.8276825846;11655.747468731455;11725.472353744273;10394.428306443218;10692.518836652525;10835.512401941774;11099.167562433011;11172.608958686407;10691.893081069089;11012.17408694335;11073.390963497084;11415.885841141482;11558.248713833575;10279.17766578657;10329.328593641389;10714.946425267824;10779.67660970172;10795.838062428913;9314.484126984127;9344.34589578723;9473.33686641956;9573.234141268542;9659.951700241454;9095.272378209595;9402.858957115512;9428;9518.857217141887;9549.80079681275 04:44:00 INFO - PROCESS | 7992 | __end_tp_report 04:44:00 INFO - PROCESS | 7992 | __start_cc_report 04:44:00 INFO - PROCESS | 7992 | _x_x_mozilla_cycle_collect,1044 04:44:00 INFO - PROCESS | 7992 | __end_cc_report 04:44:00 INFO - PROCESS | 7992 | __startTimestamp1459943040160__endTimestamp 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | ------- Summary: start ------- 04:44:00 INFO - PROCESS | 7992 | Number of tests: 6 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#0] dojo.html Cycles:165 Average:4723.94 Median:4866.10 stddev:486.09 (10.0%) stddev-sans-first:460.08 04:44:00 INFO - PROCESS | 7992 | Values: 2669.2 2741.6 2743.1 2758.5 2767.8 4622.7 4697.9 4758.9 4760.1 4767.4 4705.3 4733.2 4746.4 4821.9 4826.4 4309.2 4321.2 4349.3 4371.9 4541.4 4464.0 4486.5 4494.1 4497.0 4546.8 4297.3 4341.2 4401.0 4425.6 4439.9 4368.5 4368.7 4408.6 4411.3 4435.3 4352.5 4354.8 4371.3 4393.3 4410.7 4509.3 4626.2 4656.1 4656.7 4722.7 5092.3 5100.0 5106.2 5106.5 5140.3 5105.6 5117.3 5121.9 5122.6 5166.6 4705.7 4759.7 4771.5 4842.3 4854.3 5260.7 5263.8 5266.3 5296.4 5300.3 5021.5 5029.7 5032.2 5033.0 5082.7 5035.0 5057.5 5106.1 5121.3 5121.5 5076.6 5081.3 5083.1 5084.2 5107.3 5044.1 5046.8 5048.9 5054.1 5090.0 4164.8 4255.9 4256.2 4260.2 4334.0 3767.8 3832.7 3842.9 3851.2 3851.6 4377.8 4435.3 4448.6 4451.0 4456.3 5123.9 5127.9 5151.5 5173.7 5177.4 4420.3 4422.5 4422.7 4428.7 4468.7 4515.8 4541.4 4582.6 4587.5 4623.7 4877.9 4878.0 4879.4 4888.6 4931.8 5082.6 5139.9 5152.1 5152.3 5155.6 4823.8 4836.5 4864.0 4893.6 4926.3 5005.9 5028.2 5041.5 5054.2 5064.2 5128.9 5130.0 5130.1 5132.7 5163.8 4833.4 4963.3 4988.2 5073.5 5090.2 4922.0 4924.2 4940.8 4942.6 4981.9 4864.8 4865.0 4866.1 4866.2 4917.2 4887.5 4970.0 5019.0 5023.1 5064.4 4846.2 4876.2 4884.2 4885.5 4928.1 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#1] ext.html Cycles:180 Average:38937.55 Median:18381.26 stddev:59092.00 (321.5%) stddev-sans-first:59187.39 04:44:00 INFO - PROCESS | 7992 | Values: 528.9 539.3 542.5 553.6 586.1 27381.2 34464.3 35038.1 35043.1 35139.0 38200.0 38636.8 38637.0 38674.8 38698.8 7633.2 7830.9 7833.8 7834.3 7837.1 7759.1 7893.6 7894.8 7895.6 8030.2 8023.9 8087.9 8090.4 8092.3 8092.3 7989.8 8054.7 8059.5 8063.8 8065.6 7951.2 8072.8 8076.1 8076.3 8077.2 38425.6 38888.8 38908.2 38925.6 38931.6 3050.3 3094.2 3108.2 3254.3 3345.3 28816.6 29469.6 29493.7 29559.0 29685.9 3362.0 3373.8 3377.2 3446.8 3509.3 225664.0 227702.0 228873.0 229415.0 229572.0 56572.7 56780.1 56881.7 56928.7 57054.7 52934.7 60115.4 62491.0 63461.4 63575.7 14304.8 14558.6 14652.3 14653.7 14671.8 10769.6 10773.1 10831.7 10836.8 10852.3 17435.5 17910.2 19921.7 20495.3 20495.6 7411.3 7439.4 7585.8 7662.7 7678.3 900.1 907.6 1001.7 1020.4 1027.9 27445.7 27522.3 27937.7 28227.6 28381.9 988.7 997.4 1013.2 1026.5 1082.8 14381.8 14596.6 14724.6 14788.5 14948.0 267576.0 269218.0 271593.0 271969.0 272412.0 47526.5 48547.8 48590.3 48591.8 48647.8 1158.0 1196.1 1241.7 1256.3 1266.9 24359.9 24658.5 25217.5 25296.0 25602.5 35177.5 35305.0 35493.8 35496.0 35530.5 161747.2 165813.0 174036.0 174123.0 174292.0 29149.7 29965.4 30408.5 30491.7 30495.4 38469.6 38721.4 39054.6 39401.2 39542.4 32252.4 32597.5 33243.3 33726.2 33742.8 32283.8 32295.2 32597.8 32816.8 33242.5 33143.5 33417.2 33486.2 34773.5 35477.9 27324.5 28358.7 28821.0 28889.0 29101.0 22617.1 24179.5 24500.5 24644.3 24698.3 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#2] jquery.html Cycles:180 Average:23301.79 Median:4981.54 stddev:63293.17 (1270.6%) stddev-sans-first:63447.24 04:44:00 INFO - PROCESS | 7992 | Values: 337.2 344.4 346.8 350.1 350.5 15622.6 16135.1 16289.3 17205.6 17674.1 16329.3 16680.8 16692.7 16826.1 16843.6 4910.6 5052.5 5083.8 5098.3 5099.7 5157.6 5169.0 5190.8 5200.4 5201.7 5157.8 5172.4 5174.1 5176.0 5176.0 5674.9 5678.3 5745.3 5774.9 5870.6 5181.4 5199.1 5265.2 5272.2 5274.7 18196.7 18243.5 18771.6 18786.1 18812.2 1927.9 1954.3 2026.1 2074.7 2206.4 9171.1 9294.6 9385.8 9424.5 9811.8 1698.2 1715.7 1739.1 1813.5 1826.1 55826.7 57494.4 59374.0 60142.4 61698.4 8839.7 9205.7 9439.3 9808.2 9886.1 13196.9 13212.4 13281.9 13294.5 13298.5 6864.6 6929.8 6980.3 7140.9 7282.6 6505.4 6512.4 6605.9 6761.1 6937.6 4205.9 4210.8 4244.6 4246.2 4265.0 1723.5 1746.7 1764.2 1767.7 1836.3 831.1 845.4 876.9 879.8 950.9 15590.5 15959.0 16023.9 16060.4 16570.0 832.4 840.3 867.5 880.5 896.2 9016.4 9283.8 9363.3 9390.8 9536.0 354407.0 372770.0 398303.0 399463.0 400969.0 55341.7 69657.0 69861.3 70290.0 72363.6 906.0 907.2 928.6 929.0 947.5 15077.8 15398.4 15409.4 15537.8 15772.7 34021.8 34183.7 34221.0 34346.0 34616.5 45834.0 47349.8 47388.5 47513.0 47900.8 7397.1 7464.7 7503.2 7538.7 7598.4 8593.9 11884.1 11953.2 11977.5 12009.2 9837.4 9983.0 10259.2 10331.1 10423.7 9431.3 10230.2 10455.2 10458.4 10677.8 10634.6 10960.8 11058.1 11130.6 11445.8 7380.5 7504.2 7517.0 7576.1 7628.0 9485.9 10455.3 10589.8 10687.1 10753.8 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#3] mootools.html Cycles:180 Average:5344.31 Median:6283.25 stddev:2772.00 (44.1%) stddev-sans-first:2764.02 04:44:00 INFO - PROCESS | 7992 | Values: 1412.0 1420.3 1542.9 1748.3 1779.8 7356.4 7533.2 7561.1 7575.8 7577.6 6528.1 7083.6 7242.6 7266.5 7432.5 2237.2 2255.5 2260.5 2262.3 2262.3 1914.3 2215.5 2241.4 2260.1 2264.1 2206.2 2263.7 2264.3 2265.5 2273.5 2224.7 2245.7 2252.1 2266.1 2271.9 2192.5 2195.1 2201.8 2208.5 2209.8 7611.3 7663.8 7670.2 7848.8 7850.2 4648.4 4728.7 4746.7 4760.7 4760.8 2896.6 2921.3 2980.3 2982.7 2991.2 897.3 898.5 919.5 935.8 970.2 10657.1 10678.5 10679.7 10683.2 10722.0 4240.2 4337.2 4357.9 4390.5 4394.8 9056.5 9081.5 9091.1 9094.7 9101.5 4748.2 4757.6 4790.7 4792.2 4798.0 4250.1 4290.8 4294.8 4301.5 4309.4 3478.9 3652.8 3681.5 3692.9 3697.3 1055.6 1135.3 1165.1 1174.2 1174.5 1192.3 1200.3 1219.8 1237.6 1243.5 6974.2 7044.0 7056.9 7080.1 7264.3 1051.1 1052.4 1059.7 1077.5 1090.1 5513.5 5548.6 5553.9 5635.5 5641.5 9039.1 9347.7 9399.7 9408.0 9431.9 9167.0 9421.8 9512.0 9533.6 9543.1 6982.5 7154.8 7184.6 7188.2 7194.7 7084.2 7139.6 7159.7 7226.4 7242.9 8054.4 8195.6 8248.3 8304.0 8415.2 8493.7 8515.2 8545.8 8643.1 8654.3 6675.9 6753.8 6807.9 6826.0 6834.8 6999.5 7061.8 7081.3 7081.6 7092.8 5448.4 6489.2 6683.2 6716.2 6858.3 6203.2 6213.3 6234.1 6262.8 6303.7 6559.9 6595.8 6615.1 6622.6 6623.8 6216.8 6336.0 6342.2 6344.1 6362.2 6415.2 6448.2 6461.5 6466.9 6503.7 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#4] prototype.html Cycles:180 Average:4725.35 Median:5305.30 stddev:1376.17 (25.9%) stddev-sans-first:1339.49 04:44:00 INFO - PROCESS | 7992 | Values: 307.7 312.9 313.9 315.5 316.2 5299.0 5311.6 5366.5 5375.2 5380.2 5270.8 5287.0 5339.6 5343.5 5368.0 3986.2 4071.1 4158.2 4171.9 4179.1 4157.0 4158.0 4191.3 4201.7 4202.6 4154.1 4156.5 4156.7 4159.1 4162.0 3938.6 4038.7 4163.6 4167.9 4174.3 3672.9 3684.7 3698.8 3699.7 3701.1 5145.3 5147.5 5158.9 5160.6 5163.7 4844.8 4848.3 4853.4 4857.0 4868.6 5684.4 5689.5 5692.4 5693.4 5696.5 4070.1 4072.3 4075.8 4076.7 4086.6 5688.9 5921.8 5938.9 5949.0 5953.9 4136.2 4143.2 4154.0 4159.8 4178.5 4212.5 4213.7 4219.1 4227.8 4234.1 4793.7 4795.1 4796.7 4803.4 4804.4 5653.1 5655.8 5662.6 5663.5 5669.4 1467.5 1491.2 1496.0 1496.7 1497.4 935.0 975.6 1010.3 1012.4 1019.4 4919.1 4996.1 5011.7 5032.6 5038.7 5838.4 5864.5 5872.9 5875.9 5879.0 4959.5 5000.7 5005.6 5044.8 5056.9 3144.5 3179.8 3181.1 3185.4 3188.0 5604.2 5608.1 5608.9 5614.3 5614.5 5838.9 6058.3 6060.2 6066.5 6068.7 5554.1 5574.4 5580.0 5586.7 5594.9 5915.5 5917.4 5918.6 5922.3 5926.7 5774.2 5775.4 5786.2 5786.8 5788.8 5427.7 5584.8 5596.5 5597.3 5602.7 4179.7 4196.8 4199.4 4202.4 4208.1 5862.5 5880.4 5886.5 5894.2 5894.2 5643.4 5680.3 5697.3 5699.3 5708.1 5692.9 5696.8 5697.1 5700.1 5707.6 5474.2 5552.8 5618.7 5620.9 5622.3 5713.0 5735.0 5740.1 5741.6 5746.1 5596.0 5597.6 5603.8 5604.9 5610.5 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - PROCESS | 7992 | [#5] yui.html Cycles:180 Average:12522.58 Median:45046.77 stddev:14193.97 (31.5%) stddev-sans-first:14205.97 04:44:00 INFO - PROCESS | 7992 | Values: 688.4 688.5 697.4 697.7 706.7 10863.5 10876.2 10912.9 10915.5 10982.6 11156.2 11202.6 11262.8 11265.0 11282.3 637.9 769.2 786.4 805.8 819.9 814.0 817.7 820.2 821.0 821.1 861.8 864.7 866.6 868.6 869.0 676.8 835.0 853.8 854.2 855.0 625.1 626.8 627.0 627.4 627.5 11659.9 11742.9 11771.9 11774.9 11786.7 11853.3 12308.1 12381.1 12575.7 12762.7 9956.9 10016.3 10140.3 10151.5 10232.2 3270.2 3312.9 3316.5 3336.4 3362.3 44935.6 44950.8 45004.3 45031.0 45062.5 9142.2 9670.0 9682.8 9698.9 9782.0 17588.3 17616.5 17648.3 17678.8 17704.6 6344.5 6549.7 6550.9 6608.4 6697.2 3615.1 3635.4 3725.8 3747.8 3762.8 2797.8 2818.5 2818.9 2837.9 2837.9 456.8 465.2 480.7 484.4 486.3 558.5 604.5 604.6 612.4 647.6 7375.6 7493.2 7606.2 7740.0 7849.0 541.9 544.9 546.7 557.1 566.3 3498.2 3549.7 3573.8 3653.8 3669.6 49711.8 49955.0 50030.7 50203.7 50812.5 45341.3 45424.0 45519.8 45955.5 46206.1 40972.4 41469.6 42112.0 42187.4 42203.8 8218.4 8256.7 8263.7 8384.9 8404.3 30541.7 30765.5 31047.7 31265.1 31762.2 36749.6 36753.0 37806.8 40793.8 41024.6 9206.3 9327.9 10109.1 10190.1 10362.6 11281.4 11293.7 11487.8 11655.7 11725.5 10394.4 10692.5 10835.5 11099.2 11172.6 10691.9 11012.2 11073.4 11415.9 11558.2 10279.2 10329.3 10714.9 10779.7 10795.8 9314.5 9344.3 9473.3 9573.2 9660.0 9095.3 9402.9 9428.0 9518.9 9549.8 04:44:00 INFO - PROCESS | 7992 | -------- Summary: end -------- 04:44:00 INFO - PROCESS | 7992 | 04:44:00 INFO - TEST-INFO | 7992: exit 0 04:44:00 INFO - TEST-OK | dromaeo_css | took 1118307ms 04:44:00 INFO - TEST-START | kraken 04:44:00 INFO - operating with platform_type : linux_ 04:44:00 INFO - Initialising browser for kraken test... 04:44:00 INFO - TEST-INFO | started process 8169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNatWuH/profile http://localhost:57359/getInfo.html) 04:44:06 INFO - PROCESS | 8169 | __metrics Screen width/height:1600/1200 04:44:06 INFO - PROCESS | 8169 | colorDepth:24 04:44:06 INFO - PROCESS | 8169 | Browser inner width/height: 1024/697 04:44:06 INFO - PROCESS | 8169 | __metrics 04:44:08 ERROR - PROCESS | 8169 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:44:09 INFO - TEST-INFO | 8169: exit 0 04:44:09 INFO - Browser initialized. 04:44:09 INFO - Running cycle 1/1 for kraken test... 04:44:09 INFO - TEST-INFO | started process 8248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNatWuH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:20 INFO - PROCESS | 8248 | RSS: Main: 154390528 04:44:20 INFO - PROCESS | 8248 | 04:44:23 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:24 INFO - PROCESS | 8248 | RSS: Main: 195325952 04:44:24 INFO - PROCESS | 8248 | 04:44:26 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-dft) 04:44:27 INFO - PROCESS | 8248 | RSS: Main: 185544704 04:44:27 INFO - PROCESS | 8248 | 04:44:30 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-fft) 04:44:31 INFO - PROCESS | 8248 | RSS: Main: 169656320 04:44:31 INFO - PROCESS | 8248 | 04:44:33 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57359/tests/kraken/driver.html?testName=audio-oscillator) 04:44:33 INFO - PROCESS | 8248 | RSS: Main: 171507712 04:44:33 INFO - PROCESS | 8248 | 04:44:36 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:36 INFO - PROCESS | 8248 | RSS: Main: 173494272 04:44:36 INFO - PROCESS | 8248 | 04:44:39 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:40 INFO - PROCESS | 8248 | RSS: Main: 174030848 04:44:40 INFO - PROCESS | 8248 | 04:44:43 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57359/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:44 INFO - PROCESS | 8248 | RSS: Main: 174993408 04:44:44 INFO - PROCESS | 8248 | 04:44:47 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57359/tests/kraken/driver.html?testName=json-parse-financial) 04:44:47 INFO - PROCESS | 8248 | RSS: Main: 174034944 04:44:47 INFO - PROCESS | 8248 | 04:44:49 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:49 INFO - PROCESS | 8248 | RSS: Main: 186204160 04:44:49 INFO - PROCESS | 8248 | 04:44:51 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:52 INFO - PROCESS | 8248 | RSS: Main: 183336960 04:44:52 INFO - PROCESS | 8248 | 04:44:54 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:55 INFO - PROCESS | 8248 | RSS: Main: 196407296 04:44:55 INFO - PROCESS | 8248 | 04:44:57 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:58 INFO - PROCESS | 8248 | RSS: Main: 201510912 04:44:58 INFO - PROCESS | 8248 | 04:45:00 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:01 INFO - PROCESS | 8248 | RSS: Main: 200974336 04:45:01 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | Cycle 1(1): loaded http://localhost:57359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57359/tests/kraken/driver.html?testName=ai-astar) 04:45:03 INFO - PROCESS | 8248 | RSS: Main: 262795264 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | __start_tp_report 04:45:03 INFO - PROCESS | 8248 | _x_x_mozilla_page_load 04:45:03 INFO - PROCESS | 8248 | _x_x_mozilla_page_load_details 04:45:03 INFO - PROCESS | 8248 | |i|pagename|runs| 04:45:03 INFO - PROCESS | 8248 | |0;ai-astar;112;113;108;112;111;113;100;111;111;111 04:45:03 INFO - PROCESS | 8248 | |1;audio-beat-detection;161;130;152;175;132;158;163;137;186;133 04:45:03 INFO - PROCESS | 8248 | |2;audio-dft;163;160;161;161;160;160;161;161;160;162 04:45:03 INFO - PROCESS | 8248 | |3;audio-fft;76;74;100;111;74;73;73;115;108;75 04:45:03 INFO - PROCESS | 8248 | |4;audio-oscillator;93;93;140;94;94;94;146;93;95;138 04:45:03 INFO - PROCESS | 8248 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;116;117;117 04:45:03 INFO - PROCESS | 8248 | |6;imaging-darkroom;146;147;145;145;145;146;146;145;145;145 04:45:03 INFO - PROCESS | 8248 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 04:45:03 INFO - PROCESS | 8248 | |8;json-parse-financial;64;64;64;67;64;64;64;73;63;63 04:45:03 INFO - PROCESS | 8248 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;63;63;63 04:45:03 INFO - PROCESS | 8248 | |10;stanford-crypto-aes;81;82;84;82;82;82;82;82;81;82 04:45:03 INFO - PROCESS | 8248 | |11;stanford-crypto-ccm;118;124;123;117;124;133;126;120;117;117 04:45:03 INFO - PROCESS | 8248 | |12;stanford-crypto-pbkdf2;149;133;141;143;148;140;145;140;140;145 04:45:03 INFO - PROCESS | 8248 | |13;stanford-crypto-sha256-iterative;70;69;69;69;66;66;76;66;66;66 04:45:03 INFO - PROCESS | 8248 | __end_tp_report 04:45:03 INFO - PROCESS | 8248 | __start_cc_report 04:45:03 INFO - PROCESS | 8248 | _x_x_mozilla_cycle_collect,1170 04:45:03 INFO - PROCESS | 8248 | __end_cc_report 04:45:03 INFO - PROCESS | 8248 | __startTimestamp1459943103466__endTimestamp 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | ------- Summary: start ------- 04:45:03 INFO - PROCESS | 8248 | Number of tests: 14 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.85 (3.5%) stddev-sans-first:4.03 04:45:03 INFO - PROCESS | 8248 | Values: 112.0 113.0 108.0 112.0 111.0 113.0 100.0 111.0 111.0 111.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:159.50 stddev:19.40 (12.2%) stddev-sans-first:20.35 04:45:03 INFO - PROCESS | 8248 | Values: 161.0 130.0 152.0 175.0 132.0 158.0 163.0 137.0 186.0 133.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.71 04:45:03 INFO - PROCESS | 8248 | Values: 163.0 160.0 161.0 161.0 160.0 160.0 161.0 161.0 160.0 162.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#3] audio-fft Cycles:10 Average:87.90 Median:73.50 stddev:18.13 (24.7%) stddev-sans-first:18.71 04:45:03 INFO - PROCESS | 8248 | Values: 76.0 74.0 100.0 111.0 74.0 73.0 73.0 115.0 108.0 75.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.50 stddev:23.09 (24.7%) stddev-sans-first:23.85 04:45:03 INFO - PROCESS | 8248 | Values: 93.0 93.0 140.0 94.0 94.0 94.0 146.0 93.0 95.0 138.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:45:03 INFO - PROCESS | 8248 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:45:03 INFO - PROCESS | 8248 | Values: 146.0 147.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:45:03 INFO - PROCESS | 8248 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:3.02 (4.7%) stddev-sans-first:3.18 04:45:03 INFO - PROCESS | 8248 | Values: 64.0 64.0 64.0 67.0 64.0 64.0 64.0 73.0 63.0 63.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:45:03 INFO - PROCESS | 8248 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 04:45:03 INFO - PROCESS | 8248 | Values: 81.0 82.0 84.0 82.0 82.0 82.0 82.0 82.0 81.0 82.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.50 stddev:5.17 (4.2%) stddev-sans-first:5.29 04:45:03 INFO - PROCESS | 8248 | Values: 118.0 124.0 123.0 117.0 124.0 133.0 126.0 120.0 117.0 117.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.00 stddev:4.67 (3.2%) stddev-sans-first:4.30 04:45:03 INFO - PROCESS | 8248 | Values: 149.0 133.0 141.0 143.0 148.0 140.0 145.0 140.0 140.0 145.0 04:45:03 INFO - PROCESS | 8248 | 04:45:03 INFO - PROCESS | 8248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:3.16 (4.6%) stddev-sans-first:3.30 04:45:03 INFO - PROCESS | 8248 | Values: 70.0 69.0 69.0 69.0 66.0 66.0 76.0 66.0 66.0 66.0 04:45:03 INFO - PROCESS | 8248 | -------- Summary: end -------- 04:45:03 INFO - PROCESS | 8248 | 04:45:04 INFO - TEST-INFO | 8248: exit 0 04:45:04 INFO - TEST-OK | kraken | took 63442ms 04:45:04 INFO - SUITE-END | took 1181s 04:45:04 INFO - Completed test suite (00:19:42) 04:45:04 INFO - javascript benchmark 04:45:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2669.1725565074826, 2741.6435863337765, 2743.1084897408336, 2758.544840101383, 2767.8339299642016, 4622.722636641804, 4697.882552936178, 4758.857234282973, 4760.095581839448, 4767.380240568726, 4705.270683044134, 4733.195356789345, 4746.382970213867, 4821.927671084928, 4826.3725715657, 4309.224339618867, 4321.222180007598, 4349.325854492558, 4371.868843934687, 4541.409616749818, 4463.977680111595, 4486.484054333744, 4494.101179764044, 4497.0, 4546.795394207269, 4297.269464191095, 4341.196878577473, 4400.977995110036, 4425.645948324126, 4439.88900277494, 4368.453943257093, 4368.737875727435, 4408.58118478744, 4411.2941929291155, 4435.3125265583885, 4352.477702675699, 4354.7604881731495, 4371.2568863293, 4393.275109606943, 4410.669199809995, 4509.301058335963, 4626.236670949289, 4656.068786242731, 4656.65075119364, 4722.7402492862875, 5092.337996060489, 5100.0, 5106.234064890296, 5106.4893510648635, 5140.306058682105, 5105.642605017651, 5117.283580298761, 5121.871953201163, 5122.615803814691, 5166.612504062173, 4705.670603057822, 4759.6668233223345, 4771.475137734881, 4842.297866809293, 4854.320395144682, 5260.736963151827, 5263.842084737464, 5266.34170728659, 5296.364436267672, 5300.31095957523, 5021.5229553192385, 5029.673071250357, 5032.245163225545, 5033.018561380496, 5082.74586270685, 5035.043341765053, 5057.544820966131, 5106.131957567222, 5121.308623335876, 5121.4622464641425, 5076.6192535559985, 5081.28861959326, 5083.059633967728, 5084.161113416319, 5107.310513080761, 5044.117279476077, 5046.84859454217, 5048.924266136011, 5054.115529782347, 5090.0, 4164.7709375984, 4255.851045213402, 4256.233877902007, 4260.190563792869, 4334.0, 3767.7550959187565, 3832.7125465590193, 3842.9039274018373, 3851.1912498375655, 3851.5763266040713, 4377.846775362847, 4435.290353543418, 4448.5773851484055, 4451.043025749479, 4456.309272062836, 5123.897522049539, 5127.9230811537855, 5151.484851514819, 5173.715445650525, 5177.404598471148, 4420.31485119807, 4422.469303683514, 4422.668299877522, 4428.734275943454, 4468.731876087445, 4515.841945531956, 4541.364209010741, 4582.587567118975, 4587.495375508692, 4623.69945953512, 4877.926831097466, 4877.95122048775, 4879.39007624047, 4888.584470320063, 4931.802727890844, 5082.593392528663, 5139.897202055863, 5152.098382783073, 5152.252923326022, 5155.587552995827, 4823.782929768098, 4836.492168322276, 4863.95136048635, 4893.632977526629, 4926.261060840902, 5005.899882002413, 5028.195488721787, 5041.521055499722, 5054.241863720325, 5064.240363945438, 5128.948710512847, 5129.974350128375, 5130.076586214517, 5132.692038477703, 5163.8192663256605, 4833.41998960113, 4963.255511673278, 4988.176950803077, 5073.518015788494, 5090.211017292326, 4921.975390123026, 4924.212126059813, 4940.802367905388, 4942.604591632589, 4981.900361992813, 4864.756762161948, 4864.951350486592, 4866.099771542276, 4866.221404575251, 4917.188663870421, 4887.486813884633, 4969.975150124226, 5019.0, 5023.146065169003, 5064.44291127983, 4846.151923413459, 4876.244182151772, 4884.242942343943, 4885.511448855086, 4928.06366790323], "unit": "score", "name": "dojo.html", "value": 4693.886373681823}, {"lowerIsBetter": false, "replicates": [528.8862894477687, 539.3366159623663, 542.4900593442167, 553.6124712701109, 586.0974099886175, 27381.178564643044, 34464.31071378571, 35038.12404689884, 35043.123921901904, 35139.0, 38200.0, 38636.80681596588, 38637.0, 38674.806625966834, 38698.80650596743, 7633.160352361236, 7830.882536761953, 7833.764987050397, 7834.255745704178, 7837.0987336456465, 7759.107702614215, 7893.605319734019, 7894.842103157934, 7895.644695988665, 8030.196980301981, 8023.919760802376, 8087.878681819778, 8090.433669643127, 8092.2716955474, 8092.2716955474, 7989.800254993643, 8054.718084867001, 8059.5164290142775, 8063.758087257363, 8065.596720163969, 7951.244631759973, 8072.798180045487, 8076.111627720946, 8076.313513351372, 8077.192280771935, 38425.615743842485, 38888.80555597232, 38908.22183556313, 38925.610743892765, 38931.61068389336, 3050.2679356954395, 3094.241910731885, 3108.1918701137865, 3254.30032543002, 3345.3476572068457, 28816.567751483744, 29469.557956630666, 29493.70506294931, 29559.0, 29685.885718827005, 3362.0, 3373.797572145679, 3377.240120972786, 3446.7547272682414, 3509.280597477511, 225664.0, 227702.0, 228873.0, 229415.0, 229572.0, 56572.71713641405, 56780.148297775566, 56881.71559142178, 56928.71535642295, 57054.71472642693, 52934.73532632312, 60115.39884601098, 62491.0, 63461.36538634647, 63575.68212159002, 14304.785428218585, 14558.636034099232, 14652.267386630625, 14653.706925861636, 14671.77992330116, 10769.62306319275, 10773.084287835465, 10831.729206769895, 10836.783264334668, 10852.348859068481, 17435.47693569195, 17910.194041268172, 19921.701174482394, 20495.28266510665, 20495.590088198154, 7411.2588741125455, 7439.404847612178, 7585.848283034308, 7662.731804386931, 7678.308952194217, 900.1358695652116, 907.577976241051, 1001.7195185348114, 1020.4438580973388, 1027.8972102789662, 27445.725542744716, 27522.311942201606, 27937.720622793917, 28227.57658635122, 28381.858090709826, 988.7033889833021, 997.448966856545, 1013.224882964518, 1026.4559783314855, 1082.8105081610686, 14381.78427323591, 14596.635084122981, 14724.631884202981, 14788.482403116055, 14948.0, 267576.0, 269218.0, 271593.0, 271969.0, 272412.0, 47526.52473475221, 48547.75726121347, 48590.27114593284, 48591.757041214565, 48647.75676121597, 1157.988420115805, 1196.0969468051564, 1241.6647505173732, 1256.3466997161424, 1266.9303188324732, 24359.878200608884, 24658.506829862945, 25217.49565008726, 25296.0, 25602.487950241262, 35177.47233791546, 35305.0, 35493.82253088718, 35496.0, 35530.467042993856, 161747.19126404292, 165813.0, 174036.0, 174123.0, 174292.0, 29149.7085029147, 29965.400691986473, 30408.5438718415, 30491.695083048886, 30495.390092198475, 38469.6153038466, 38721.41917871178, 39054.6094539051, 39401.211975760896, 39542.40686389764, 32252.354952900343, 32597.511037334934, 33243.335133296714, 33726.156846079044, 33742.78570114872, 32283.838580806947, 32295.192620183745, 32597.837010814794, 32816.835915821226, 33242.501362479095, 33143.50284745779, 33417.16457088495, 33486.162845929044, 34773.47839782456, 35477.93566193018, 27324.497152656, 28358.71641283561, 28821.0, 28889.0, 29101.0, 22617.11318960053, 24179.51640967206, 24500.509989799746, 24644.260672179862, 24698.259052228463], "unit": "score", "name": "ext.html", "value": 16866.26003461858}, {"lowerIsBetter": false, "replicates": [337.1537441023032, 344.3783969934271, 346.8283199816091, 350.1194495842954, 350.4900369961706, 15622.609434764137, 16135.11256880871, 16289.26698298575, 17205.569860753487, 17674.116294185304, 16329.304305679798, 16680.83319166808, 16692.74960875588, 16826.07456589887, 16843.57891052724, 4910.582600478954, 5052.4947505249365, 5083.84748457545, 5098.311727916739, 5099.745012749367, 5157.6131790115705, 5168.974155129219, 5190.844274671747, 5200.427952925175, 5201.713905735183, 5157.7936882524655, 5172.379314482268, 5174.068667639824, 5175.974120129394, 5176.016556854186, 5674.858128546778, 5678.3186017678145, 5745.253117094772, 5774.884502309972, 5870.559708021916, 5181.4300426953005, 5199.1161502544655, 5265.210218467222, 5272.182811664198, 5274.683518988873, 18196.72704909414, 18243.45269641913, 18771.624567508574, 18786.060696965233, 18812.153453094645, 1927.8650494465394, 1954.3452943264024, 2026.1490174126902, 2074.730285062947, 2206.437358473595, 9171.082891710843, 9294.581743821544, 9385.812283754287, 9424.528773561295, 9811.803763924681, 1698.2188193431036, 1715.7254839225789, 1739.1391261325725, 1813.4831573001632, 1826.0960824391877, 55826.720866395815, 57494.42505574933, 59374.0, 60142.39857601455, 61698.38301616971, 8839.674048892717, 9205.677801277057, 9439.339246252697, 9808.215342772704, 9886.110250077527, 13196.868031319564, 13212.405441755143, 13281.867181328063, 13294.534691285759, 13298.534551290659, 6864.553804002724, 6929.826754331081, 6980.336867997532, 7140.892886606705, 7282.635868206675, 6505.381988711065, 6512.413882750575, 6605.900911486331, 6761.087253220752, 6937.618430986243, 4205.852795152155, 4210.831566737357, 4244.578066347808, 4246.171996460722, 4264.957350426518, 1723.4743403262125, 1746.6855965926002, 1764.2237415537122, 1767.6553072151064, 1836.3205613922667, 831.1461067366608, 845.446232717571, 876.8816209811721, 879.784452809053, 950.8954015058338, 15590.532284031497, 15959.0, 16023.919880400523, 16060.43788467398, 16570.0, 832.4464231286248, 840.3487297344485, 867.4665080975154, 880.5157163560017, 896.171041786345, 9016.413933094327, 9283.76790580241, 9363.34456588046, 9390.765230869147, 9536.0, 354407.0, 372770.0, 398303.0, 399463.0, 400969.0, 55341.723291383285, 69657.0, 69861.3013869865, 70290.0, 72363.63818180875, 905.9547022648973, 907.2424525521131, 928.5728564860104, 929.0430856218106, 947.5309721687809, 15077.849221508084, 15398.384064637288, 15409.383624654889, 15537.84462155364, 15772.68454630924, 34021.829890851375, 34183.658163419044, 34221.0, 34346.0, 34616.48075278923, 45834.0, 47349.763251183525, 47388.52611473841, 47513.0, 47900.7604961973, 7397.112346518452, 7464.738734144279, 7503.161725377317, 7538.736144234926, 7598.430117741302, 8593.914060859312, 11884.108691847972, 11953.22304050234, 11977.461014254553, 12009.159358844798, 9837.360571562825, 9983.0, 10259.230557708352, 10331.121854642439, 10423.739406514898, 9431.339806213498, 10230.23273254494, 10455.215858810467, 10458.372497650165, 10677.786444271227, 10634.627788027381, 10960.780784384428, 11058.115350771757, 11130.610428634958, 11445.828312575151, 7380.520266182895, 7504.249575042452, 7517.0, 7576.1287451941525, 7628.0464941882265, 9485.857712134186, 10455.320404173704, 10589.841152382874, 10687.091597214323, 10753.784924301626], "unit": "score", "name": "jquery.html", "value": 8002.90110936492}, {"lowerIsBetter": false, "replicates": [1411.9929400352996, 1420.3040510150026, 1542.9382824687013, 1748.2832038864053, 1779.7775278090246, 7356.4114870810345, 7533.246675332464, 7561.054868141482, 7575.810604734885, 7577.621118944045, 6528.053432252321, 7083.64581770912, 7242.6016569088815, 7266.491345605809, 7432.479726419153, 2237.2393386248673, 2255.458689914417, 2260.457490202356, 2262.2873794754682, 2262.309995451387, 1914.3204162522313, 2215.523662412581, 2241.3500084975417, 2260.0846657103816, 2264.094362255095, 2206.249875042485, 2263.7057182566246, 2264.286749673856, 2265.546890621874, 2273.5111950930545, 2224.721909761288, 2245.6856040154394, 2252.087904398721, 2266.1275408967504, 2271.8523295985706, 2192.473806286496, 2195.1438938813876, 2201.7908298711595, 2208.514126892081, 2209.767974362685, 7611.276928691821, 7663.846723065563, 7670.232976702341, 7848.803779905491, 7850.214978502161, 4648.418947631546, 4728.692634978715, 4746.715197088186, 4760.714357138583, 4760.785764640599, 2896.6379202599674, 2921.2550799546193, 2980.2698338907107, 2982.7166419190144, 2991.1774262077884, 897.3180382908971, 898.532762963262, 919.5080631861989, 935.8315503209419, 970.1947383671536, 10657.094146997515, 10678.51946662402, 10679.679609611647, 10683.198760092946, 10722.0, 4240.173166232555, 4337.240982827992, 4357.934630980538, 4390.4511936008, 4394.824207031683, 9056.547172641342, 9081.54592270384, 9091.090890910857, 9094.681686140953, 9101.453912765122, 4748.216544270226, 4757.571818536279, 4790.730456429049, 4792.161371759928, 4798.04039192156, 4250.086231460251, 4290.82836686529, 4294.76378799169, 4301.505326887448, 4309.353596960418, 3478.926015937385, 3652.8356223969986, 3681.5214022176947, 3692.9076773080888, 3697.2975134724315, 1055.6041484443333, 1135.335828540313, 1165.056304393444, 1174.213277104342, 1174.5008371442102, 1192.3322939154102, 1200.327816422806, 1219.810929305959, 1237.641084085623, 1243.4777393494753, 6974.232834388214, 7044.049053377831, 7056.858862822714, 7080.079589653312, 7264.273572642799, 1051.0803047333584, 1052.3843551522446, 1059.6609085092696, 1077.488193108283, 1090.1061129873585, 5513.5037846593195, 5548.5838562108, 5553.916691249635, 5635.549156067505, 5641.548676105902, 9039.141281578239, 9347.672831450867, 9399.671011514563, 9407.952960235156, 9431.858522122173, 9166.954165229132, 9421.76445588852, 9511.952440237754, 9533.570989305359, 9543.093406126407, 6982.546134501241, 7154.821129471805, 7184.604846733584, 7188.209296977328, 7194.676239569232, 7084.185318688416, 7139.643017848983, 7159.677814498256, 7226.385757210696, 7242.927570724225, 8054.395920306118, 8195.631196596287, 8248.257656810916, 8304.0, 8415.158484151782, 8493.660253590035, 8515.233628973423, 8545.786355340917, 8643.092475290256, 8654.264387526879, 6675.899861502178, 6753.831154221184, 6807.863842723019, 6825.965870170618, 6834.829129271808, 6999.510034297754, 7061.752838650623, 7081.291870813084, 7081.610511421715, 7092.751753688596, 5448.427915068861, 6489.221293444817, 6683.164604424447, 6716.1604799400075, 6858.348456896587, 6203.16257305258, 6213.316535181217, 6234.096056071753, 6262.812115636538, 6303.684815759286, 6559.868802623825, 6595.835104122435, 6615.140031795836, 6622.602643841385, 6623.768168114093, 6216.7824126155365, 6335.968320158369, 6342.175517182736, 6344.111824344688, 6362.172917520693, 6415.166028416276, 6448.193975753031, 6461.483081353575, 6466.870662586628, 6503.739850405931], "unit": "score", "name": "mootools.html", "value": 4396.185357455111}, {"lowerIsBetter": false, "replicates": [307.66618219232134, 312.85764976935496, 313.88856955780705, 315.4889079690901, 316.21263054993045, 5298.973505132474, 5311.628186026975, 5366.4633536646415, 5375.193720941861, 5380.24676545283, 5270.762815673294, 5287.048331300364, 5339.5728341732665, 5343.492368225022, 5368.0, 3986.2027594481074, 4071.1043570414463, 4158.168366326747, 4171.874843754692, 4179.080602267496, 4157.0, 4158.022864626811, 4191.329387298033, 4201.684873634475, 4202.621764041236, 4154.127633197032, 4156.521999970012, 4156.667466602665, 4159.064210552617, 4161.979190104045, 3938.6061393860673, 4038.6567141792984, 4163.562825903282, 4167.854125105637, 4174.31123864562, 3672.889813305605, 3684.7236457265544, 3698.7780733156096, 3699.6855267302312, 3701.0747313171705, 5145.305383773218, 5147.536721695065, 5158.871028224287, 5160.638755287131, 5163.66436181647, 4844.806207751686, 4848.29699693546, 4853.39332583427, 4857.028594281122, 4868.561829435368, 5684.403137670526, 5689.544836413077, 5692.37383887772, 5693.430656934273, 5696.487316141567, 4070.1249231415386, 4072.287349713818, 4075.7554546727292, 4076.653484453825, 4086.5504794472586, 5688.943110568883, 5921.792737254218, 5938.910916336258, 5949.0, 5953.8809223815715, 4136.152088821785, 4143.233501802116, 4153.979230103831, 4159.750414975111, 4178.498580170399, 4212.473440819897, 4213.6839737019845, 4219.07180420307, 4227.7528129201955, 4234.06850492891, 4793.736344501086, 4795.136875362398, 4796.736179510161, 4803.3995750531185, 4804.399450068741, 5653.067243904709, 5655.80204692842, 5662.5753068520025, 5663.490285874291, 5669.376368599451, 1467.4790449390525, 1491.1873029199112, 1496.0350573879787, 1496.6931778985281, 1497.423491955605, 934.9532523373804, 975.5658731864253, 1010.3331801011298, 1012.3875055591409, 1019.4189312092185, 4919.1391506486225, 4996.100701873697, 5011.699298042129, 5032.647714660012, 5038.697678139323, 5838.357780644125, 5864.530837532987, 5872.911906321408, 5875.941240587625, 5879.0, 4959.479254678206, 5000.724960127228, 5005.5745261653165, 5044.823431179964, 5056.9494305057215, 3144.5283207519055, 3179.8251096189933, 3181.0933883843454, 3185.442547554169, 3187.9840600796847, 5604.159376093618, 5608.10270356741, 5608.887822243532, 5614.29821272341, 5614.494695477427, 5838.883222335529, 6058.273007239071, 6060.212172417558, 6066.48434883031, 6068.696565171724, 5554.0835762099605, 5574.386817450078, 5579.972100139555, 5586.748596313176, 5594.944050559605, 5915.526757859275, 5917.378675239038, 5918.615290006136, 5922.289325280994, 5926.67403292823, 5774.220480235114, 5775.364709881994, 5786.247787787561, 5786.826395208151, 5788.82633520995, 5427.674339539641, 5584.776608935759, 5596.524295434933, 5597.3003374578175, 5602.691851948182, 4179.665626749914, 4196.8111434984885, 4199.370094485852, 4202.432671589297, 4208.116295577841, 5862.501687356452, 5880.353161152356, 5886.529077673861, 5894.204282421818, 5894.20428242199, 5643.407442218508, 5680.289963754531, 5697.3448053474385, 5699.2590963174525, 5708.086706127166, 5692.857678558069, 5696.772129114789, 5697.116946873241, 5700.144978253295, 5707.571932105192, 5474.1827192072315, 5552.750126244248, 5618.719064046863, 5620.85947851307, 5622.32532096151, 5712.971665100322, 5735.0, 5740.0815869460685, 5741.569382296261, 5746.109353050284, 5595.972020139873, 5597.5521958242425, 5603.8318850432925, 5604.8879022418505, 5610.5231055360755], "unit": "score", "name": "prototype.html", "value": 4284.057402614444}, {"lowerIsBetter": false, "replicates": [688.390774164864, 688.4698781937911, 697.3863000559509, 697.6511744127936, 706.7349743846057, 10863.45682715863, 10876.184286178539, 10912.945435272832, 10915.454227288634, 10982.615608453705, 11156.219064665476, 11202.551897924073, 11262.774744505105, 11265.0, 11282.266652667591, 637.8915584350648, 769.1769806307253, 786.3709032773787, 805.7582725182451, 819.9139090395512, 814.0, 817.6565842346229, 820.2412768189431, 821.0188824354898, 821.1255013410728, 861.8362511122898, 864.7016779211193, 866.5580553917484, 868.5961028121922, 869.0310304011014, 676.8003438985511, 834.9540775257389, 853.8121613245077, 854.2482615298528, 855.0252711908367, 625.1185827982523, 626.8182227154119, 627.0187157099125, 627.3600927054379, 627.4823270801606, 11659.941700291443, 11742.882571174265, 11771.882281177164, 11774.94112529432, 11786.705332366673, 11853.348065856375, 12308.07689423288, 12381.071419643473, 12575.685607859785, 12762.68093297675, 9956.900430995669, 10016.298859079867, 10140.340877842917, 10151.543180556819, 10232.181425486018, 3270.2314955985325, 3312.9006129815903, 3316.5025246213263, 3336.382769187708, 3362.3107263011025, 44935.550644493465, 44950.775246123885, 45004.324935126, 45031.0, 45062.54937450616, 9142.222911052502, 9670.0, 9682.806343873082, 9698.903010969942, 9782.0, 17588.296468141132, 17616.471505854846, 17648.294068237126, 17678.823211767718, 17704.557386065193, 6344.524160687874, 6549.705263263165, 6550.934490655128, 6608.43828274602, 6697.162854643169, 3615.07815507044, 3635.381985062546, 3725.8137093145233, 3747.8126093695205, 3762.793046382475, 2797.8321300722023, 2818.450402171598, 2818.873150708223, 2837.9148625541266, 2837.929051773722, 456.8149899290793, 465.2393336894202, 480.73319307784516, 484.39934481243006, 486.2730218323629, 558.4694540186839, 604.4559896093463, 604.6160687963174, 612.3967891626744, 647.6211416321411, 7375.594342311224, 7493.175750667422, 7606.201348858401, 7739.961300193576, 7848.960755196302, 541.8753686652013, 544.9427810079964, 546.6965833962189, 557.0557904352085, 566.2582017557013, 3498.2129020970588, 3549.698275646599, 3573.8391772370305, 3653.7990410527677, 3669.614690457517, 49711.75144124256, 49955.0, 50030.74984625127, 50203.74898125486, 50812.49187508078, 45341.31988020182, 45424.0, 45519.77240113778, 45955.5404445958, 46206.07587848224, 40972.385414218814, 41469.585304146574, 42112.0, 42187.36718949157, 42203.788981054895, 8218.383621228551, 8256.669733210605, 8263.710770123016, 8384.916150838413, 8404.32765378756, 30541.694583053886, 30765.538516921817, 31047.68952310448, 31265.090292327102, 31762.205944851565, 36749.63250367462, 36753.0, 37806.81096594499, 40793.79603101966, 41024.589754102075, 9206.29683508553, 9327.906720932704, 10109.14072303833, 10190.133838623504, 10362.637307694195, 11281.379524126252, 11293.71765705864, 11487.8276825846, 11655.747468731455, 11725.472353744273, 10394.428306443218, 10692.518836652525, 10835.512401941774, 11099.167562433011, 11172.608958686407, 10691.893081069089, 11012.17408694335, 11073.390963497084, 11415.885841141482, 11558.248713833575, 10279.17766578657, 10329.328593641389, 10714.946425267824, 10779.67660970172, 10795.838062428913, 9314.484126984127, 9344.34589578723, 9473.33686641956, 9573.234141268542, 9659.951700241454, 9095.272378209595, 9402.858957115512, 9428.0, 9518.857217141887, 9549.80079681275], "unit": "score", "name": "yui.html", "value": 5809.007003521111}], "name": "dromaeo_css", "value": 6409.322840090299}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 112.0, 111.0, 113.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 152.0, 175.0, 132.0, 158.0, 163.0, 137.0, 186.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 100.0, 111.0, 74.0, 73.0, 73.0, 115.0, 108.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 94.0, 94.0, 94.0, 146.0, 93.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 67.0, 64.0, 64.0, 64.0, 73.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 123.0, 117.0, 124.0, 133.0, 126.0, 120.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [149.0, 133.0, 141.0, 143.0, 148.0, 140.0, 145.0, 140.0, 140.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 66.0, 66.0, 76.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1519.7}]} 04:45:04 INFO - Return code: 0 04:45:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:45:04 ERROR - # TBPL SUCCESS # 04:45:04 INFO - Running post-action listener: _resource_record_post_action 04:45:04 INFO - Running post-run listener: _resource_record_post_run 04:45:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 388194304; Read time: 0; Write time: 641500 04:45:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 107237376; Read time: 0; Write time: 193340 04:45:05 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 280956928; Read time: 0; Write time: 448160 04:45:05 INFO - Running post-run listener: _upload_blobber_files 04:45:05 INFO - Blob upload gear active. 04:45:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:45:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:07 INFO - (blobuploader) - INFO - Done attempting. 04:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:07 INFO - (blobuploader) - INFO - Done attempting. 04:45:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:07 INFO - Return code: 0 04:45:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d54ab9cd8b80dc881d02c7c0504d6d9e88b6bd1edcbf1fb7d84d5edca044043996ce7c10f608545c7dc9a348995987609a16d23df24208d5cb4c4fb2b4a3ce92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b96d557f00c83761b92c8c182b024ce53420666af45206650bfc62c36bcc8ba52b39595bf540811bf8666990a53dc095bd19fb36c56b66b0bb65d924f9ecc1"} 04:45:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:07 INFO - Contents: 04:45:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d54ab9cd8b80dc881d02c7c0504d6d9e88b6bd1edcbf1fb7d84d5edca044043996ce7c10f608545c7dc9a348995987609a16d23df24208d5cb4c4fb2b4a3ce92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b96d557f00c83761b92c8c182b024ce53420666af45206650bfc62c36bcc8ba52b39595bf540811bf8666990a53dc095bd19fb36c56b66b0bb65d924f9ecc1"} 04:45:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:07 INFO - Copying logs to upload dir... 04:45:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.322714 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-06 04:45:07.871774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:45:07.875064) ========= 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 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-Non-PGO/sha512/d54ab9cd8b80dc881d02c7c0504d6d9e88b6bd1edcbf1fb7d84d5edca044043996ce7c10f608545c7dc9a348995987609a16d23df24208d5cb4c4fb2b4a3ce92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b96d557f00c83761b92c8c182b024ce53420666af45206650bfc62c36bcc8ba52b39595bf540811bf8666990a53dc095bd19fb36c56b66b0bb65d924f9ecc1"} build_url:https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011665 build_url: 'https://queue.taskcluster.net/v1/task/Fj3s_pa5SRmvA_5jnYc3Fw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d54ab9cd8b80dc881d02c7c0504d6d9e88b6bd1edcbf1fb7d84d5edca044043996ce7c10f608545c7dc9a348995987609a16d23df24208d5cb4c4fb2b4a3ce92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b96d557f00c83761b92c8c182b024ce53420666af45206650bfc62c36bcc8ba52b39595bf540811bf8666990a53dc095bd19fb36c56b66b0bb65d924f9ecc1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:45:07.902156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:45:07.902566) ========= 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=5cf47e208febbcd81da23b2e0000026f-1459941691.434433-1408836705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:45:07.987951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:45:07.988621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:45:07.989319) ========= ========= Total master_lag: 0.29 =========