builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1459833830.72 results: success (0) buildid: 20160404205918 builduid: ac2c2a53227b4a28a9b16f153b96fc9f revision: bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.721783) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.722918) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.723715) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004349 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.745615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.745954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.761360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.761863) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.816396) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.817111) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:50.817946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:23:50.818610) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 22:23:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.4M=0s 2016-04-04 22:23:51 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.492141 ========= master_lag: 1.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:23:52.482908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:52.483237) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022408 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:52.521475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:23:52.521847) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 --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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 22:23:52,916 truncating revision to first 12 chars 2016-04-04 22:23:52,917 Setting DEBUG logging. 2016-04-04 22:23:52,917 attempt 1/10 2016-04-04 22:23:52,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc3a8e4f9a3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:23:53,297 unpacking tar archive at: fx-team-bc3a8e4f9a3a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666493 ========= master_lag: 0.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:23:54.087581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:54.088009) ========= echo bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0'] 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 program finished with exit code 0 elapsedTime=0.004745 script_repo_revision: 'bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0' ========= master_lag: 0.50 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:54.590319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:54.590633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:23:54.605280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-04 22:23:54.605606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:23:55 INFO - MultiFileLogger online at 20160404 22:23:55 in /builds/slave/test 22:23:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:23:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:23:55 INFO - {'append_to_log': False, 22:23:55 INFO - 'base_work_dir': '/builds/slave/test', 22:23:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:23:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:23:55 INFO - 'branch': 'Fx-Team-Non-PGO', 22:23:55 INFO - 'buildbot_json_path': 'buildprops.json', 22:23:55 INFO - 'config_files': ('talos/linux_config.py',), 22:23:55 INFO - 'default_actions': ('clobber', 22:23:55 INFO - 'read-buildbot-config', 22:23:55 INFO - 'download-and-extract', 22:23:55 INFO - 'populate-webroot', 22:23:55 INFO - 'create-virtualenv', 22:23:55 INFO - 'install', 22:23:55 INFO - 'run-tests'), 22:23:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:23:55 INFO - 'download_minidump_stackwalk': True, 22:23:55 INFO - 'download_symbols': 'ondemand', 22:23:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:23:55 INFO - 'tooltool.py': '/tools/tooltool.py', 22:23:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:23:55 INFO - '/tools/misc-python/virtualenv.py')}, 22:23:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:23:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:23:55 INFO - 'installer_path': 'installer.exe', 22:23:55 INFO - 'log_level': 'info', 22:23:55 INFO - 'log_name': 'talos', 22:23:55 INFO - 'log_to_console': True, 22:23:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:23:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:23:55 INFO - 'opt_config_files': (), 22:23:55 INFO - 'pip_index': False, 22:23:55 INFO - 'sps_profile': False, 22:23:55 INFO - 'sps_profile_interval': 0, 22:23:55 INFO - 'suite': 'dromaeojs', 22:23:55 INFO - 'system_bits': '32', 22:23:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:23:55 INFO - 'title': 'talos-linux64-ix-068', 22:23:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:23:55 INFO - 'use_talos_json': True, 22:23:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:23:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:23:55 INFO - 'work_dir': 'build'} 22:23:55 INFO - ##### 22:23:55 INFO - ##### Running clobber step. 22:23:55 INFO - ##### 22:23:55 INFO - Running pre-action listener: _resource_record_pre_action 22:23:55 INFO - Running main action method: clobber 22:23:55 INFO - rmtree: /builds/slave/test/build 22:23:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:23:55 INFO - Running post-action listener: _resource_record_post_action 22:23:55 INFO - ##### 22:23:55 INFO - ##### Running read-buildbot-config step. 22:23:55 INFO - ##### 22:23:55 INFO - Running pre-action listener: _resource_record_pre_action 22:23:55 INFO - Running main action method: read_buildbot_config 22:23:55 INFO - Using buildbot properties: 22:23:55 INFO - { 22:23:55 INFO - "project": "", 22:23:55 INFO - "product": "firefox", 22:23:55 INFO - "script_repo_revision": "production", 22:23:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:23:55 INFO - "repository": "", 22:23:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:23:55 INFO - "buildid": "20160404205918", 22:23:55 INFO - "pgo_build": "False", 22:23:55 INFO - "basedir": "/builds/slave/test", 22:23:55 INFO - "buildnumber": 2753, 22:23:55 INFO - "slavename": "talos-linux64-ix-068", 22:23:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:23:55 INFO - "platform": "ubuntu64_hw", 22:23:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:23:55 INFO - "branch": "fx-team", 22:23:55 INFO - "repo_path": "integration/fx-team", 22:23:55 INFO - "revision": "bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0", 22:23:55 INFO - "stage_platform": "linux64", 22:23:55 INFO - "builduid": "ac2c2a53227b4a28a9b16f153b96fc9f", 22:23:55 INFO - "slavebuilddir": "test" 22:23:55 INFO - } 22:23:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:23:55 INFO - Running post-action listener: _resource_record_post_action 22:23:55 INFO - ##### 22:23:55 INFO - ##### Running download-and-extract step. 22:23:55 INFO - ##### 22:23:55 INFO - Running pre-action listener: _resource_record_pre_action 22:23:55 INFO - Running main action method: download_and_extract 22:23:55 INFO - mkdir: /builds/slave/test/build/tests 22:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:55 INFO - https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:23:56 INFO - Downloaded 1361 bytes. 22:23:56 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:23:56 INFO - Using the following test package requirements: 22:23:56 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:23:56 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:23:56 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:23:56 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'jsshell-linux-x86_64.zip'], 22:23:56 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:23:56 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:23:56 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:23:56 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:23:56 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:23:56 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:23:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:56 INFO - https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:23:57 INFO - Downloaded 22125516 bytes. 22:23:57 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'] 22:23:57 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 22:23:59 INFO - Return code: 0 22:23:59 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 22:23:59 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')]} 22:23:59 INFO - https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:23:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:23:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:24:00 INFO - Downloaded 22125516 bytes. 22:24:00 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'] 22:24:00 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 22:24:01 INFO - Return code: 0 22:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:01 INFO - https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:24:02 INFO - Downloaded 10847584 bytes. 22:24:02 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'] 22:24:02 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 22:24:02 INFO - Return code: 0 22:24:02 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')]} 22:24:02 INFO - https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:24:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:24:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:24:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZLnNJtgVRryR6esfPrKBTA/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 22:24:04 INFO - Downloaded 54084020 bytes. 22:24:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:24:04 INFO - mkdir: /builds/slave/test/properties 22:24:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:24:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:24:04 INFO - Contents: 22:24:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:24:05 INFO - Running post-action listener: _resource_record_post_action 22:24:05 INFO - Running post-action listener: set_extra_try_arguments 22:24:05 INFO - ##### 22:24:05 INFO - ##### Running populate-webroot step. 22:24:05 INFO - ##### 22:24:05 INFO - Running pre-action listener: _resource_record_pre_action 22:24:05 INFO - Running main action method: populate_webroot 22:24:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:05 INFO - '--tppagecycles', 22:24:05 INFO - '7'], 22:24:05 INFO - 'tests': ['tsvgm']}}, 22:24:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:24:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:24:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:24:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'tests': ['damp', 'tps']}, 22:24:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['damp', 'tps']}, 22:24:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:24:05 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['dromaeo_dom']}, 22:24:05 INFO - 'other': {'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'other_l64': {'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'other_nol64': {'tests': ['a11yr', 22:24:05 INFO - 'ts_paint', 22:24:05 INFO - 'tpaint', 22:24:05 INFO - 'sessionrestore', 22:24:05 INFO - 'sessionrestore_no_auto_restore', 22:24:05 INFO - 'tabpaint']}, 22:24:05 INFO - 'svgr': {'tests': ['tsvgx', 22:24:05 INFO - 'tsvgr_opacity', 22:24:05 INFO - 'tart', 22:24:05 INFO - 'tscrollx', 22:24:05 INFO - 'cart']}, 22:24:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['tsvgx', 22:24:05 INFO - 'tsvgr_opacity', 22:24:05 INFO - 'tart', 22:24:05 INFO - 'tscrollx', 22:24:05 INFO - 'cart']}, 22:24:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'tests': ['tp5o']}, 22:24:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'talos_options': ['--e10s'], 22:24:05 INFO - 'tests': ['tp5o']}, 22:24:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'talos_options': ['--xperf_path', 22:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:05 INFO - 'tests': ['tp5n']}, 22:24:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:05 INFO - 'talos_options': ['--e10s', 22:24:05 INFO - '--xperf_path', 22:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:05 INFO - 'tests': ['tp5n']}}, 22:24:05 INFO - 'talos.zip': {'path': '', 22:24:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:05 INFO - Running post-action listener: _resource_record_post_action 22:24:05 INFO - ##### 22:24:05 INFO - ##### Running create-virtualenv step. 22:24:05 INFO - ##### 22:24:05 INFO - Running pre-action listener: _resource_record_pre_action 22:24:05 INFO - Running main action method: create_virtualenv 22:24:05 INFO - Creating virtualenv /builds/slave/test/build/venv 22:24:05 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 22:24:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:24:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:05 INFO - Using real prefix '/usr' 22:24:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:24:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:07 INFO - Installing pip.................done. 22:24:07 INFO - Return code: 0 22:24:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:07 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:07 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 22:24:07 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 22:24:07 INFO - Using env: {'DISPLAY': ':0', 22:24:07 INFO - 'HOME': '/home/cltbld', 22:24:07 INFO - 'LANG': 'en_US.UTF-8', 22:24:07 INFO - 'LANGUAGE': 'en_US:en', 22:24:07 INFO - 'LOGNAME': 'cltbld', 22:24:07 INFO - 'MAIL': '/var/mail/cltbld', 22:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:07 INFO - 'MOZ_NO_REMOTE': '1', 22:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:07 INFO - 'NO_EM_RESTART': '1', 22:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:07 INFO - 'PWD': '/builds/slave/test', 22:24:07 INFO - 'SHELL': '/bin/bash', 22:24:07 INFO - 'SHLVL': '1', 22:24:07 INFO - 'TERM': 'linux', 22:24:07 INFO - 'TMOUT': '86400', 22:24:07 INFO - 'USER': 'cltbld', 22:24:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:07 INFO - '_': '/tools/buildbot/bin/python'} 22:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:07 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 22:24:07 INFO - Cleaning up... 22:24:07 INFO - Return code: 0 22:24:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:07 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:07 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 22:24:07 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 22:24:07 INFO - Using env: {'DISPLAY': ':0', 22:24:07 INFO - 'HOME': '/home/cltbld', 22:24:07 INFO - 'LANG': 'en_US.UTF-8', 22:24:07 INFO - 'LANGUAGE': 'en_US:en', 22:24:07 INFO - 'LOGNAME': 'cltbld', 22:24:07 INFO - 'MAIL': '/var/mail/cltbld', 22:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:07 INFO - 'MOZ_NO_REMOTE': '1', 22:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:07 INFO - 'NO_EM_RESTART': '1', 22:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:07 INFO - 'PWD': '/builds/slave/test', 22:24:07 INFO - 'SHELL': '/bin/bash', 22:24:07 INFO - 'SHLVL': '1', 22:24:07 INFO - 'TERM': 'linux', 22:24:07 INFO - 'TMOUT': '86400', 22:24:07 INFO - 'USER': 'cltbld', 22:24:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:07 INFO - '_': '/tools/buildbot/bin/python'} 22:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:08 INFO - Downloading/unpacking psutil>=0.7.1 22:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:10 INFO - Installing collected packages: psutil 22:24:10 INFO - Running setup.py install for psutil 22:24:10 INFO - building 'psutil._psutil_linux' extension 22:24:10 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 22:24:10 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 22:24:10 INFO - building 'psutil._psutil_posix' extension 22:24:10 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 22:24:10 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 22:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:10 INFO - Successfully installed psutil 22:24:10 INFO - Cleaning up... 22:24:10 INFO - Return code: 0 22:24:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:24:10 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')]} 22:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:10 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')]} 22:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:10 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:10 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 22:24:10 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 22:24:10 INFO - Using env: {'DISPLAY': ':0', 22:24:10 INFO - 'HOME': '/home/cltbld', 22:24:10 INFO - 'LANG': 'en_US.UTF-8', 22:24:10 INFO - 'LANGUAGE': 'en_US:en', 22:24:10 INFO - 'LOGNAME': 'cltbld', 22:24:10 INFO - 'MAIL': '/var/mail/cltbld', 22:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:10 INFO - 'MOZ_NO_REMOTE': '1', 22:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:10 INFO - 'NO_EM_RESTART': '1', 22:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:10 INFO - 'PWD': '/builds/slave/test', 22:24:10 INFO - 'SHELL': '/bin/bash', 22:24:10 INFO - 'SHLVL': '1', 22:24:10 INFO - 'TERM': 'linux', 22:24:10 INFO - 'TMOUT': '86400', 22:24:10 INFO - 'USER': 'cltbld', 22:24:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:10 INFO - '_': '/tools/buildbot/bin/python'} 22:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:24:12 INFO - Installing collected packages: mozsystemmonitor 22:24:12 INFO - Running setup.py install for mozsystemmonitor 22:24:12 INFO - Successfully installed mozsystemmonitor 22:24:12 INFO - Cleaning up... 22:24:12 INFO - Return code: 0 22:24:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:12 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:12 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 22:24:12 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 22:24:12 INFO - Using env: {'DISPLAY': ':0', 22:24:12 INFO - 'HOME': '/home/cltbld', 22:24:12 INFO - 'LANG': 'en_US.UTF-8', 22:24:12 INFO - 'LANGUAGE': 'en_US:en', 22:24:12 INFO - 'LOGNAME': 'cltbld', 22:24:12 INFO - 'MAIL': '/var/mail/cltbld', 22:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:12 INFO - 'MOZ_NO_REMOTE': '1', 22:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:12 INFO - 'NO_EM_RESTART': '1', 22:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:12 INFO - 'PWD': '/builds/slave/test', 22:24:12 INFO - 'SHELL': '/bin/bash', 22:24:12 INFO - 'SHLVL': '1', 22:24:12 INFO - 'TERM': 'linux', 22:24:12 INFO - 'TMOUT': '86400', 22:24:12 INFO - 'USER': 'cltbld', 22:24:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:12 INFO - '_': '/tools/buildbot/bin/python'} 22:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:13 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:13 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 22:24:13 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 22:24:13 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 22:24:13 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 22:24:13 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 22:24:13 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 22:24:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:24:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 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 22:24:15 INFO - Downloading docopt-0.6.1.tar.gz 22:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:15 INFO - Running setup.py install for blobuploader 22:24:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:24:15 INFO - Running setup.py install for requests 22:24:16 INFO - Running setup.py install for docopt 22:24:16 INFO - Successfully installed blobuploader requests docopt 22:24:16 INFO - Cleaning up... 22:24:16 INFO - Return code: 0 22:24:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:16 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')]} 22:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:16 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')]} 22:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:16 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:16 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 22:24:16 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 22:24:16 INFO - Using env: {'DISPLAY': ':0', 22:24:16 INFO - 'HOME': '/home/cltbld', 22:24:16 INFO - 'LANG': 'en_US.UTF-8', 22:24:16 INFO - 'LANGUAGE': 'en_US:en', 22:24:16 INFO - 'LOGNAME': 'cltbld', 22:24:16 INFO - 'MAIL': '/var/mail/cltbld', 22:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:16 INFO - 'MOZ_NO_REMOTE': '1', 22:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:16 INFO - 'NO_EM_RESTART': '1', 22:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:16 INFO - 'PWD': '/builds/slave/test', 22:24:16 INFO - 'SHELL': '/bin/bash', 22:24:16 INFO - 'SHLVL': '1', 22:24:16 INFO - 'TERM': 'linux', 22:24:16 INFO - 'TMOUT': '86400', 22:24:16 INFO - 'USER': 'cltbld', 22:24:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:16 INFO - '_': '/tools/buildbot/bin/python'} 22:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:16 INFO - Running setup.py (path:/tmp/pip-7VsWCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:16 INFO - Running setup.py (path:/tmp/pip-B74h4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:16 INFO - Running setup.py (path:/tmp/pip-ltsNCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:16 INFO - Running setup.py (path:/tmp/pip-3tiF0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:16 INFO - Running setup.py (path:/tmp/pip-clKV4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:17 INFO - Running setup.py (path:/tmp/pip-paKdcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:17 INFO - Running setup.py (path:/tmp/pip-f3bOFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:17 INFO - Running setup.py (path:/tmp/pip-OFukbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:17 INFO - Running setup.py (path:/tmp/pip-LEPmi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:17 INFO - Running setup.py (path:/tmp/pip-esJyJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:17 INFO - Running setup.py (path:/tmp/pip-ZhrAxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:17 INFO - Running setup.py (path:/tmp/pip-tRAXMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:17 INFO - Running setup.py (path:/tmp/pip-oqUJBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:17 INFO - Running setup.py (path:/tmp/pip-Q95Gdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:17 INFO - Running setup.py (path:/tmp/pip-sCnfrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:17 INFO - Running setup.py (path:/tmp/pip-_KCrsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:17 INFO - Running setup.py (path:/tmp/pip-dFmOi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:17 INFO - Running setup.py install for manifestparser 22:24:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:17 INFO - Running setup.py install for mozcrash 22:24:18 INFO - Running setup.py install for mozdebug 22:24:18 INFO - Running setup.py install for mozdevice 22:24:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for mozfile 22:24:18 INFO - Running setup.py install for mozhttpd 22:24:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for mozinfo 22:24:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for mozInstall 22:24:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for mozleak 22:24:18 INFO - Running setup.py install for mozlog 22:24:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for moznetwork 22:24:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:18 INFO - Running setup.py install for mozprocess 22:24:19 INFO - Running setup.py install for mozprofile 22:24:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:19 INFO - Running setup.py install for mozrunner 22:24:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:19 INFO - Running setup.py install for mozscreenshot 22:24:19 INFO - Running setup.py install for moztest 22:24:19 INFO - Running setup.py install for mozversion 22:24:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:19 INFO - Cleaning up... 22:24:19 INFO - Return code: 0 22:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:19 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')]} 22:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:19 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')]} 22:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:19 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:19 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 22:24:19 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 22:24:19 INFO - Using env: {'DISPLAY': ':0', 22:24:19 INFO - 'HOME': '/home/cltbld', 22:24:19 INFO - 'LANG': 'en_US.UTF-8', 22:24:19 INFO - 'LANGUAGE': 'en_US:en', 22:24:19 INFO - 'LOGNAME': 'cltbld', 22:24:19 INFO - 'MAIL': '/var/mail/cltbld', 22:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:19 INFO - 'MOZ_NO_REMOTE': '1', 22:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:19 INFO - 'NO_EM_RESTART': '1', 22:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:19 INFO - 'PWD': '/builds/slave/test', 22:24:19 INFO - 'SHELL': '/bin/bash', 22:24:19 INFO - 'SHLVL': '1', 22:24:19 INFO - 'TERM': 'linux', 22:24:19 INFO - 'TMOUT': '86400', 22:24:19 INFO - 'USER': 'cltbld', 22:24:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:19 INFO - '_': '/tools/buildbot/bin/python'} 22:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:19 INFO - Running setup.py (path:/tmp/pip-6XNuR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:19 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)) 22:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:19 INFO - Running setup.py (path:/tmp/pip-oo0rRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:20 INFO - Running setup.py (path:/tmp/pip-n8pm9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:20 INFO - Running setup.py (path:/tmp/pip-KCtWTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:20 INFO - Running setup.py (path:/tmp/pip-8sQzuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:20 INFO - Running setup.py (path:/tmp/pip-Q1TiQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:20 INFO - Running setup.py (path:/tmp/pip-zLroGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:20 INFO - Running setup.py (path:/tmp/pip-GbCdOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:20 INFO - Running setup.py (path:/tmp/pip-f6tD67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:20 INFO - Running setup.py (path:/tmp/pip-znJEQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:20 INFO - Running setup.py (path:/tmp/pip-7D__P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:20 INFO - Running setup.py (path:/tmp/pip-UuppBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:20 INFO - Running setup.py (path:/tmp/pip-2FdilL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:20 INFO - Running setup.py (path:/tmp/pip-zo2jkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:20 INFO - Running setup.py (path:/tmp/pip-63oAQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:20 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)) 22:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:20 INFO - Running setup.py (path:/tmp/pip-kNjxd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:21 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)) 22:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:21 INFO - Running setup.py (path:/tmp/pip-7a4Y9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:21 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)) 22:24:21 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)) 22:24:21 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)) 22:24:21 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)) 22:24:21 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)) 22:24:21 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)) 22:24:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:22 INFO - Downloading blessings-1.6.tar.gz 22:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:23 INFO - Installing collected packages: blessings 22:24:23 INFO - Running setup.py install for blessings 22:24:23 INFO - Successfully installed blessings 22:24:23 INFO - Cleaning up... 22:24:23 INFO - Return code: 0 22:24:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:23 INFO - Reading from file tmpfile_stdout 22:24:23 INFO - Current package versions: 22:24:23 INFO - argparse == 1.2.1 22:24:23 INFO - blessings == 1.6 22:24:23 INFO - blobuploader == 1.2.4 22:24:23 INFO - docopt == 0.6.1 22:24:23 INFO - manifestparser == 1.1 22:24:23 INFO - mozInstall == 1.12 22:24:23 INFO - mozcrash == 0.17 22:24:23 INFO - mozdebug == 0.1 22:24:23 INFO - mozdevice == 0.48 22:24:23 INFO - mozfile == 1.2 22:24:23 INFO - mozhttpd == 0.7 22:24:23 INFO - mozinfo == 0.9 22:24:23 INFO - mozleak == 0.1 22:24:23 INFO - mozlog == 3.1 22:24:23 INFO - moznetwork == 0.27 22:24:23 INFO - mozprocess == 0.22 22:24:23 INFO - mozprofile == 0.28 22:24:23 INFO - mozrunner == 6.11 22:24:23 INFO - mozscreenshot == 0.1 22:24:23 INFO - mozsystemmonitor == 0.0 22:24:23 INFO - moztest == 0.7 22:24:23 INFO - mozversion == 1.4 22:24:23 INFO - psutil == 3.1.1 22:24:23 INFO - requests == 1.2.3 22:24:23 INFO - wsgiref == 0.1.2 22:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:23 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 22:24:23 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 22:24:23 INFO - Using env: {'DISPLAY': ':0', 22:24:23 INFO - 'HOME': '/home/cltbld', 22:24:23 INFO - 'LANG': 'en_US.UTF-8', 22:24:23 INFO - 'LANGUAGE': 'en_US:en', 22:24:23 INFO - 'LOGNAME': 'cltbld', 22:24:23 INFO - 'MAIL': '/var/mail/cltbld', 22:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:23 INFO - 'MOZ_NO_REMOTE': '1', 22:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:23 INFO - 'NO_EM_RESTART': '1', 22:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:23 INFO - 'PWD': '/builds/slave/test', 22:24:23 INFO - 'SHELL': '/bin/bash', 22:24:23 INFO - 'SHLVL': '1', 22:24:23 INFO - 'TERM': 'linux', 22:24:23 INFO - 'TMOUT': '86400', 22:24:23 INFO - 'USER': 'cltbld', 22:24:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:23 INFO - '_': '/tools/buildbot/bin/python'} 22:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 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)) 22:24:23 INFO - Cleaning up... 22:24:23 INFO - Return code: 0 22:24:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:24:23 INFO - Using env: {'DISPLAY': ':0', 22:24:23 INFO - 'HOME': '/home/cltbld', 22:24:23 INFO - 'LANG': 'en_US.UTF-8', 22:24:23 INFO - 'LANGUAGE': 'en_US:en', 22:24:23 INFO - 'LOGNAME': 'cltbld', 22:24:23 INFO - 'MAIL': '/var/mail/cltbld', 22:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:23 INFO - 'MOZ_NO_REMOTE': '1', 22:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:23 INFO - 'NO_EM_RESTART': '1', 22:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:23 INFO - 'PWD': '/builds/slave/test', 22:24:23 INFO - 'SHELL': '/bin/bash', 22:24:23 INFO - 'SHLVL': '1', 22:24:23 INFO - 'TERM': 'linux', 22:24:23 INFO - 'TMOUT': '86400', 22:24:23 INFO - 'USER': 'cltbld', 22:24:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:23 INFO - '_': '/tools/buildbot/bin/python'} 22:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:23 INFO - Downloading/unpacking jsonschema 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:25 INFO - Downloading/unpacking functools32 (from jsonschema) 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:25 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:26 INFO - warning: no files found matching '*.txt' 22:24:26 INFO - no previously-included directories found matching 'build' 22:24:26 INFO - no previously-included directories found matching 'dist' 22:24:26 INFO - no previously-included directories found matching '.git*' 22:24:26 INFO - Installing collected packages: jsonschema, functools32 22:24:26 INFO - Running setup.py install for functools32 22:24:26 INFO - warning: no files found matching '*.txt' 22:24:26 INFO - no previously-included directories found matching 'build' 22:24:26 INFO - no previously-included directories found matching 'dist' 22:24:26 INFO - no previously-included directories found matching '.git*' 22:24:26 INFO - Successfully installed jsonschema functools32 22:24:26 INFO - Cleaning up... 22:24:26 INFO - Return code: 0 22:24:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:26 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 0x7f8dfb85df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', '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 22:24:26 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 22:24:26 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 22:24:26 INFO - Using env: {'DISPLAY': ':0', 22:24:26 INFO - 'HOME': '/home/cltbld', 22:24:26 INFO - 'LANG': 'en_US.UTF-8', 22:24:26 INFO - 'LANGUAGE': 'en_US:en', 22:24:26 INFO - 'LOGNAME': 'cltbld', 22:24:26 INFO - 'MAIL': '/var/mail/cltbld', 22:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:26 INFO - 'MOZ_NO_REMOTE': '1', 22:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:26 INFO - 'NO_EM_RESTART': '1', 22:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:26 INFO - 'PWD': '/builds/slave/test', 22:24:26 INFO - 'SHELL': '/bin/bash', 22:24:26 INFO - 'SHLVL': '1', 22:24:26 INFO - 'TERM': 'linux', 22:24:26 INFO - 'TMOUT': '86400', 22:24:26 INFO - 'USER': 'cltbld', 22:24:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:26 INFO - '_': '/tools/buildbot/bin/python'} 22:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:26 INFO - Downloading/unpacking flake8 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:24:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:24:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:29 INFO - no previously-included directories found matching 'docs/_build' 22:24:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:24:29 INFO - Running setup.py install for pep8 22:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:29 INFO - no previously-included directories found matching 'docs/_build' 22:24:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:24:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:24:29 INFO - Cleaning up... 22:24:29 INFO - Return code: 0 22:24:29 INFO - Running post-action listener: _resource_record_post_action 22:24:29 INFO - Running post-action listener: _start_resource_monitoring 22:24:29 INFO - Starting resource monitoring. 22:24:29 INFO - ##### 22:24:29 INFO - ##### Running install step. 22:24:29 INFO - ##### 22:24:29 INFO - Running pre-action listener: _resource_record_pre_action 22:24:29 INFO - Running main action method: install 22:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:29 INFO - Reading from file tmpfile_stdout 22:24:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:29 INFO - Reading from file tmpfile_stdout 22:24:29 INFO - Output received: 22:24:29 INFO - Usage: mozinstall [options] installer 22:24:29 INFO - Options: 22:24:29 INFO - -h, --help show this help message and exit 22:24:29 INFO - -d DEST, --destination=DEST 22:24:29 INFO - Directory to install application into. [default: 22:24:29 INFO - "/builds/slave/test"] 22:24:29 INFO - --app=APP Application being installed. [default: firefox] 22:24:29 INFO - mkdir: /builds/slave/test/build/application 22:24:29 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'] 22:24:29 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 22:24:45 INFO - Reading from file tmpfile_stdout 22:24:45 INFO - Output received: 22:24:45 INFO - /builds/slave/test/build/application/firefox/firefox 22:24:45 INFO - Running post-action listener: _resource_record_post_action 22:24:45 INFO - ##### 22:24:45 INFO - ##### Running run-tests step. 22:24:45 INFO - ##### 22:24:45 INFO - Running pre-action listener: _resource_record_pre_action 22:24:45 INFO - Running main action method: run_tests 22:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:24:45 INFO - Python 2.7.3 22:24:45 INFO - Return code: 0 22:24:45 INFO - grabbing minidump binary from tooltool 22:24:45 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')]} 22:24:45 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 0xf64410>, '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 0xf65310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf657a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:24:45 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 22:24:45 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 22:24:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:45 INFO - Return code: 0 22:24:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:24:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:24:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:24:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:24:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:24:46 INFO - Return code: 0 22:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 22:24:46 INFO - Using env: {'DISPLAY': ':0', 22:24:46 INFO - 'HOME': '/home/cltbld', 22:24:46 INFO - 'LANG': 'en_US.UTF-8', 22:24:46 INFO - 'LANGUAGE': 'en_US:en', 22:24:46 INFO - 'LOGNAME': 'cltbld', 22:24:46 INFO - 'MAIL': '/var/mail/cltbld', 22:24:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:24:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:46 INFO - 'MOZ_NO_REMOTE': '1', 22:24:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:46 INFO - 'NO_EM_RESTART': '1', 22:24:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:46 INFO - 'PWD': '/builds/slave/test', 22:24:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:24:46 INFO - 'SHELL': '/bin/bash', 22:24:46 INFO - 'SHLVL': '1', 22:24:46 INFO - 'TERM': 'linux', 22:24:46 INFO - 'TMOUT': '86400', 22:24:46 INFO - 'USER': 'cltbld', 22:24:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576', 22:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:46 INFO - '_': '/tools/buildbot/bin/python'} 22:24:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:24:46 INFO - mozversion application_buildid: 20160404205918 22:24:46 INFO - mozversion application_changeset: bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 22:24:46 INFO - mozversion application_display_name: Nightly 22:24:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:46 INFO - mozversion application_name: Firefox 22:24:46 INFO - mozversion application_remotingname: firefox 22:24:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:24:46 INFO - mozversion application_vendor: Mozilla 22:24:46 INFO - mozversion application_version: 48.0a1 22:24:46 INFO - mozversion platform_buildid: 20160404205918 22:24:46 INFO - mozversion platform_changeset: bc3a8e4f9a3ae2f8a6a9e85124e373ec5ec3cab0 22:24:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:24:46 INFO - mozversion platform_version: 48.0a1 22:24:46 INFO - using testdate: 1459833886 22:24:46 INFO - actual date: 1459833886 22:24:46 INFO - starting webserver on 'localhost:35117' 22:24:46 INFO - SUITE-START | Running 2 tests 22:24:46 INFO - TEST-START | dromaeo_css 22:24:46 INFO - operating with platform_type : linux_ 22:24:46 INFO - Initialising browser for dromaeo_css test... 22:24:46 INFO - TEST-INFO | started process 7668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoiyC_/profile http://localhost:35117/getInfo.html) 22:24:51 INFO - PROCESS | 7668 | __metrics Screen width/height:1600/1200 22:24:51 INFO - PROCESS | 7668 | colorDepth:24 22:24:51 INFO - PROCESS | 7668 | Browser inner width/height: 1024/697 22:24:51 INFO - PROCESS | 7668 | __metrics 22:24:52 ERROR - PROCESS | 7668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:24:53 INFO - TEST-INFO | 7668: exit 0 22:24:53 INFO - Browser initialized. 22:24:53 INFO - Running cycle 1/1 for dromaeo_css test... 22:24:53 INFO - TEST-INFO | started process 7752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoiyC_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:05 INFO - PROCESS | 7752 | RSS: Main: 154419200 22:25:05 INFO - PROCESS | 7752 | 22:25:55 INFO - PROCESS | 7752 | 1459833955832 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] 22:28:07 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35117/tests/dromaeo/cssquery-ext.html) 22:28:08 INFO - PROCESS | 7752 | RSS: Main: 232501248 22:28:08 INFO - PROCESS | 7752 | 22:31:10 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-ext.html (next: http://localhost:35117/tests/dromaeo/cssquery-jquery.html) 22:31:11 INFO - PROCESS | 7752 | RSS: Main: 238776320 22:31:11 INFO - PROCESS | 7752 | 22:34:13 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35117/tests/dromaeo/cssquery-mootools.html) 22:34:13 INFO - PROCESS | 7752 | RSS: Main: 233111552 22:34:13 INFO - PROCESS | 7752 | 22:37:15 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35117/tests/dromaeo/cssquery-prototype.html) 22:37:16 INFO - PROCESS | 7752 | RSS: Main: 221790208 22:37:16 INFO - PROCESS | 7752 | 22:40:19 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35117/tests/dromaeo/cssquery-yui.html) 22:40:19 INFO - PROCESS | 7752 | RSS: Main: 200134656 22:40:19 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | Cycle 1(1): loaded http://localhost:35117/tests/dromaeo/cssquery-yui.html (next: http://localhost:35117/tests/dromaeo/cssquery-dojo.html) 22:43:22 INFO - PROCESS | 7752 | RSS: Main: 259031040 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | __start_tp_report 22:43:22 INFO - PROCESS | 7752 | _x_x_mozilla_page_load 22:43:22 INFO - PROCESS | 7752 | _x_x_mozilla_page_load_details 22:43:22 INFO - PROCESS | 7752 | |i|pagename|runs| 22:43:22 INFO - PROCESS | 7752 | |0;dojo.html;2586.883590238439;2660.042384741494;2668.9733102668965;2678.7990900682453;2686.113582517769;4516.480604730457;4547.295169248768;4563.88590285243;4588.403507544019;4594;4627.490975992638;4639.373684552585;4661.254199328099;4696.248600223965;4698.130845793522;4191.874243772691;4208.158368326332;4231.090315582149;4259.6379307758725;4352.477702675684;4301.440812694361;4311.935320970188;4320.65434765218;4344.283193273106;4358.3244597087505;4210.305299625558;4255.2978758504805;4258.254805409041;4285.657147428198;4287.935680964788;4195.55946625603;4227.4292970448905;4231.915361692749;4232.936505952413;4237.089025859455;4213.115245798386;4216.325387937946;4219.725717828362;4222.1555688862045;4222.683298752575;4460.30865215892;4502.842400515966;4522.570355816192;4539.137563862855;4547.818087276505;4860.659753817235;4871.658983871131;4872.123017856784;4880.585150262232;4923.852284431473;4847.466778654345;4901.09329773993;4903.779329930162;4907.141250281186;4940.752962351868;4576.3821884045565;4606.055758569485;4607.101615185074;4654.767261636905;4658.231391820379;5014.34813474246;5033.245013248042;5053.772580233898;5055.949440505621;5099.974500127476;4734.313524538991;4797.136515427256;4821.5178482152205;4838.975805120952;4891.926621100686;4867.6836005660225;4886.65793394459;4901.142300097468;4928.28539861718;4934.963657631937;4824.807007719722;4829.275608658659;4830.3237546743485;4835.588974937099;4871.464138944713;4750.239961606127;4811.9518804811505;4820.421549414093;4837.927431088537;4873.634477414208;4100.671946244293;4118.75287482752;4135.0902801383645;4155.625993660585;4162.271602469556;3610.945835812465;3628.32875917956;3637.3634613942454;3663.780173189617;3685.023468780775;4191.622753952159;4258.127083947783;4273.786310684453;4278.358246263086;4289;4962.528559786814;4965.081459929852;4968.155413579628;4987.600991920638;5019.799208031711;4291.270484017725;4304.80628371724;4306.1172459645695;4306.138772245564;4358.084802191575;4271.765052922119;4345.717528360647;4404.537523560044;4409.007973206003;4411.801468933906;4622.722636641813;4644.094401591725;4645.883852903705;4690.530946905282;4695.671303008757;4900.411950565955;4903.681260718042;4908.852734417973;4918.1393256180745;4965.776540055778;4571.657125715651;4663.603593694574;4668.766561671835;4735.981763920774;4748.833790817304;4868.537488938545;4877.195262781602;4899.926501102557;4903.387076615423;4944.604431645388;4947.2579113133315;4971;4972.7762250699525;4974.32846565709;5023.246513023076;4662.137504561667;4748.9050218994735;4785.138675038526;4799.3760811094335;4834.129856625841;4791.113643975876;4809.615230781599;4825.9758701207675;4832.275158726219;4873.074115917964;4597.149527337453;4685.390899183084;4741.57325840676;4749.145153872336;4797.328374027708;4774.21225497789;4804.591609713214;4814.085323788469;4858.198397264412;4861.51384861511;4642.350070990132;4709.481956984798;4712.740799256074;4716.127516409475;4755.667103302736 22:43:22 INFO - PROCESS | 7752 | |1;ext.html;516.3571353664687;525.9132243179876;532.1352801697242;535.7803300646735;545.5799034743245;34223.48664770027;34406.31187376251;34495.82752086239;34506.48240276398;34508.1372965676;38005.61994380056;38223.23553528928;38410.61589384105;38605.806970965175;38728;7590.392768578514;7727.49771264866;7750.8449831003345;7765.107012693527;7772.3393511551585;7592.50648707835;7704.306612404883;7709.922900770976;7722.8455430891345;7727.806804829868;7856.450048496607;7911.446198766089;7921.445498815086;7922.326602238817;7927;7821.569813660247;7884.566348850783;7893.763187104396;7901.486403383762;7926.564038977854;7895.881561776578;8015.358771298283;8021.237982391722;8022.1175670676175;8025.95987020067;38238.23523529542;38681.806590966866;38695.61304386948;38767.03082422962;38777.61222387768;3170.3183815479783;3297.505374193866;3317.8672853085845;3694.8522059117604;3857.1707082977014;29205.26986825325;29330.706692933225;29446.411071778657;29465.558016629766;30451;3352.4803655433448;3368.456646162882;3369.241920567877;3384.5769278840144;3491.6159222485508;170435;170551;170623.14688426603;170688;170895;47663.28505072427;49190;58760.706196468745;60184.69907650434;60393;52564.63459144348;52629.894964179344;52883.735581321846;52906;52917.47082529125;14933.850661493463;15054.473093441677;15164.165970871487;15166.924165379103;15174.165420901956;10155.492225388702;10861.83707244392;10991.120710343313;11006.394648294421;11007.284526505751;18958.336458223897;19000.334988275343;19037.714434283498;19054.80945190558;19103.808961910203;6978.930210697929;7104.928950710427;7105.71577136919;7135.678894449762;7141.500094993301;875.4309698695898;897.4615230861431;952.2619969523536;968.3947532792005;1049.5644307612408;26858.462830743665;27158.456830863273;27609.585856212172;27746.02888898879;27864.303392414946;936.990630093704;970.84466485362;996.5017491254373;1009.7122320138725;1153.7807816514835;14016.229107399191;14171.716565668836;14270.286485675675;14580;14589.635259118608;291895.56731029047;293136;294368;294988;297160;48809.75595122073;49261;49300.26049609259;49330.50669493331;49350.50649493459;1102.9007389334997;1247.2454165230088;1265.2092442223611;1267.1573403686814;1334.7130366970953;24558.508829823662;24959.500809984063;26359.472810544066;26914.32714182161;27353.31616709598;38507.2298554033;38811.417828732025;38863.222735544565;38880.6111938877;38951.220975580894;199859;202527;203020;203318;203854;30181.547276790425;30361.848190758905;31286.68713312929;31331.37337253288;31371;38292;38691.03272418212;39217.41173882337;39322.2135557293;39352.803235984786;33162;33268.334633307684;33391;33428.1642958928;33688.831555842065;33171.83414082914;33997.830010849786;34027;37979.62020379761;38622.80688596539;33151.50272745959;33365.66634333723;33585.664143358255;34421.82789086038;35131;26809.19572412831;27690;27717.72282277232;27781;27867.16398508048;22357.21749738751;22409.66385504186;22452.77547224507;22899.31302060941;22925.312240632808 22:43:22 INFO - PROCESS | 7752 | |2;jquery.html;343.3167995688581;355.7100962715387;357.4013527341703;362.9346717590834;367.34612389945875;15492.845071549295;15794.763078553817;17096.316147354122;17525.649487010283;17586.82413175868;16352.509424717247;16676.66646667066;16924.323027078903;16963.660726785456;16994.7450788238;4910.1898186799135;4974.676646018006;5109.514596113382;5119.155339368999;5120.0527902338;5032.6477146599755;5052.9242061369105;5062.468440813716;5072.644914855961;5089.3638295213095;4996.4503904570465;5017.498250174972;5033.823816166435;5044.142495775727;5079.492050794928;4932.556069953704;5026.396832380138;5057.165567681328;5070.619703522232;5072.670276432039;4497.212987727167;4505.977470112662;4510.481294651091;4513.571210735008;4519.909601807945;18847.24611015558;19999.800001999938;20104.69842952357;20131.899340503205;20150.596988060304;1803.6122233719682;1935.1775495414392;1942.7085937109405;2029.6346657601625;2152.7309086364203;9334.953051409446;9402.858957115648;9722.951385243028;10946.288491248044;12789.744205115938;1757.8417942385247;1814.5191524246086;1824.2155872974615;1830.3227805711838;1859.907004649762;59253;61474.38525614731;63020.05469917955;63517.682411587644;63637.68181159111;9169.220616247694;9198.95400522993;9584.76038099053;9718.562664680107;9800.950995244979;13429.597112086652;13545.661358466117;13575.66060848467;13597.592072237849;13601.31993400326;7299.233580473974;7347.338739513362;7414.369778568882;7504.924950750423;7506.887396689054;7118.750843720549;7124.43004559634;7132.679029443688;7180.9640951795955;7195.532290401107;4276.35854621803;4299.269124248885;4311.827526898952;4324.589164029412;4362.629176519968;1764.8941063536229;1792.4891405949243;1803.4860064881445;1816.4187460012934;1824.1882362348892;835.4945258118872;867.0029466113893;875.2035647560689;900.6667533012827;914.8033172867865;15596.92201538985;15660.530184094496;16103.275352608927;16104.275307611186;16142.515724528283;911.9544022798833;924.7087167542203;930.2046750028763;960.481340076351;975.4196253229317;6343;9116.81766364669;9139.497327647043;9327.720168394959;9427.811443771086;377800;396106;401076;402400;403011;38394.616053839665;50102.74948625234;62372.68813655902;69112.65443672749;72079;901.5627420700955;914.6661468564059;927.7309580221795;929.707142250189;934.509382574154;14098;14223.786643200567;14346.426142954166;14512.63718407006;14523.273836307932;30757.384852303276;32979.83510082434;34450.65549344474;35096.47355289622;35157.648423515435;44352.33471497866;46102.769486152356;46151.76924115358;46568.767156165355;46757.532424675315;7209.747658832125;7278.272172782679;7316.268373162641;7333.779986600411;7349.412047036118;8454.830903381775;11844.466998984894;11855.288682678722;11884.881151188378;12074.215176013531;9806.705798826046;9846.556904939152;10029.29794914349;10057.497125143567;10137.189024877845;10211.693649190536;10294.948525257325;10367.222458315808;10447.84328235062;10496.737581560217;10257.846132307872;10487.475626218811;10498.475076246004;10734;10755.300905441121;7430;7433.553986760811;7433.9256607433235;7468.626568671653;7597.088349397886;10209.438480883622;10346.275760696679;10360;10399.58401663925;10489.580416783243 22:43:22 INFO - PROCESS | 7752 | |3;mootools.html;1412.8940329475288;1413.978790318145;1586.6509367939057;1731;1772.3885259585438;7018.192907815596;7211.423086153109;7228.313310235532;7229.602371869545;7235.38499227565;6225.564210505267;6390.55266131371;6392.105105285252;6402.935970640292;7099.609521476316;2109.820665243456;2180.6292930201826;2181.4328274648547;2181.5418762059985;2181.6291230490774;2096.423483542023;2103.852730308879;2135.9252426165085;2179.607670619288;2181.0403422494132;1871.7753869535675;2106.3365040012345;2147.871127732341;2160.362693005567;2181.6182168120517;2106.6945292932514;2120.183729264229;2140.668196429556;2150.7526634437004;2154.3644624835556;2050.2516581447812;2076.09689784944;2097.590969760897;2100.432883121564;2101.443117573844;7032.859342813115;7105.253948335402;7110.786676399716;7123.679434425463;7131.67907444161;4483.215437298492;4584.243599806028;4588.609968152711;4594.724316541018;4600.769961501912;2831.490331740286;2883.063004523517;2947.410517896408;2951.8819247230085;2997.5054116070824;894.4543828264754;953.8664586957832;959.4770849886828;960.9237653827757;981.5681100315838;9895.158911492532;9919.107280344731;9919.404835709809;9932.90067099327;9952.601895924226;4105.97947010263;4107.404426358161;4177.415161877339;4182.435371224907;4195.601417865298;7578.052743407075;7613.352865006425;7625.885611715828;7640.044994375703;7642.8089297768;4439.689221754511;4440.711353761995;4448.243798554189;4450.087732014929;4452.443444569429;3413.6245013048547;3995.180987897474;4104.486939132608;4112.239235741397;4115;3209.422303985258;3254.6094468663914;3268.7875288106197;3272.4273252180774;3274.6889045540634;974;1010.8433192855119;1011.7723512209694;1018.221060888421;1021.0198209718753;993.9453330066916;1019.6737044145802;1076.5478499030426;1209.195884736658;1213.878612138779;6676.198856137295;6709.664516774239;6811.863762724718;6853.17761868569;6859.657017149123;1056.4084112896649;1060.9151267898549;1063.4629512096496;1069.550788668761;1074.7581794096423;5365.22204280385;5429.945700542944;5435.701036442954;5466.316710411199;5467.097928841697;8515.063343032261;8550.78623034429;8771.03518612952;8813.955930220307;8829.558522074;8634.093420190915;8730.519821409756;8763.474191548528;8784.341174411944;8808.823823523622;6781.084553585203;6920.650473157787;6937;6973.407260382823;7029.26192749754;6562.8359291018105;6581.934180658323;6602.702878370389;6644.501662375438;6661.933380666132;7643.503172293783;7856.7250146244605;7860.528368297921;7954.08528019262;7980.401469889665;7884.132745398117;8086;8159.959200203961;8177.4684645497855;8296.626651800803;5228.137357335997;5867.794627188028;6085.756569737161;6186.257649082139;6197.349278325711;6838.213605435439;6857.451403887777;6859.794206173823;6860.176778786577;6898.034275201376;6146.754129834935;6194.0708893666315;6213.099100630474;6261.96869015652;6282.623042617458;5963.493103086286;6051.364606716407;6100.1154832548145;6144.877102457836;6171.352008039091;6238.500919926304;6417.807465776034;6418.454431373386;6439.291677915519;6441.033844923299;5990.7004649768205;6085.665288409003;6086.087086936818;6090.573659843945;6097.237845269341;6156.78451254204;6171.506279497719;6224.813255602339;6234;6236.251649802053 22:43:22 INFO - PROCESS | 7752 | |4;prototype.html;312.5296428874544;314.0797463432143;317.74739082429465;319.98240096794683;323.3936369307548;5234.895302093956;5404.162354835002;5409.729513524318;5425.2675888755;5435.157550579662;5221.817236396727;5310.62825602208;5342.305500284967;5348.732563371836;5356.437574054727;3951.486306780115;4069.6540794032544;4146.979265103678;4148.792560371984;4155.044339801847;4189.622933935945;4211.157768446307;4212.6629869610515;4221.113566151096;4221.282381995068;4175.31107367284;4179.498460184782;4185.727927684706;4188.329867221245;4196;4008.038070863001;4072.6945479089186;4172.520160181557;4182.22628813669;4194.328907374836;3694.963050369489;3713.755891776258;3715.5727091384297;3717.8512859485586;3726.720495962814;5104.387473503166;5112.769925353368;5121.180611102206;5132.0249152661245;5133.6919784813035;4802.807887684488;4822.831200907986;4831.758412079382;4832.033593281322;4838.467768545493;5590.720463976785;5591.804286849941;5594.049011668027;5608.355039170507;5616.764311851386;4065.2072845795083;4067.796610169509;4069.552349241581;4073.083556199861;4082.0611259410502;5626.352969408529;5808.186853840466;5855.121731740231;5866.941330586682;5871.706414679292;4144.109016561454;4155.58444155582;4155.646770024521;4158.854440094582;4168.499780026416;4210.936835947463;4215.515215750167;4223.97888010558;4225.176090662353;4227.217964676544;4774.21225497789;4780.856574302777;4781.52184781526;4782.187028205213;4782.928256076161;5591.804286849941;5591.860203494945;5596.104623260258;5602.327720673464;5652.547796176378;1464.531349968;1487.5016869348674;1493.3653197391066;1493.626593351662;1495.244901324824;946.3895787217344;991.8809742830906;1000.3247807729899;1007.2093406675724;1010.4695035106628;4858.65989380747;4927.610109097085;4945.109880221523;5010.098182327216;5012.097822392005;5825.330087040044;5835.4748072673665;5840;5852.94147058524;5861.824145275648;4994.750262486861;4997.925031124536;5001.374828146481;5002.824901128443;5006.924896126561;3101.41073196092;3119.516474946387;3144.1039303798307;3144.292534179837;3148.197209711509;5510.476504732044;5515.034868897927;5515.669059856422;5525.613207075547;5528.087865502147;5752.971235143881;5972.044472884318;5974.3428222895445;5987.395482964924;5991.700414979234;5476.452354764571;5493.121100623881;5499.587530935116;5507.779688812483;5511.889762204733;5826.980278451339;5841.474267315962;5865.648061116347;5908.970455147697;5912.674802885883;5625.212470254086;5641.746121424628;5656.43435656431;5708.4862362387585;5721.914171287517;5398.64908780928;5415.729213539386;5419.458054194549;5472.616916815785;5503.422140675171;3848.5766565677195;3896.805159742058;3899.9220015600094;3909.7263191576317;3988.4216788566077;5642.266505354278;5663.7451314690115;5699.715014249354;5704.486596206361;5719.170720245458;5457.426970168234;5459.918101228564;5513.531349835309;5514.6691198528215;5520.585956053232;5426.077566813572;5497.422770609189;5502.174673798802;5512.503874651301;5517.972410137923;5424.213489044146;5432.809851655173;5434.2935418395355;5437.02133615953;5444.782208711607;5472.452754724655;5655.886882262414;5669.433056694297;5692.914606280826;5693.4875861172695;5501.284832971688;5518.420565840529;5539.8892022158525;5539.8892022158525;5545.473180047889 22:43:22 INFO - PROCESS | 7752 | |5;yui.html;668.6155460610149;719.4639993205063;747.6448686873736;771.8880762289465;800.5676934455395;12289;12292.815607765868;12354.567590134347;12371.381430928452;12376.257424554533;12013.819792703116;12047.759044819099;12080;12135.271883686984;12136.514539418435;633.1041576169725;645.4707140145083;645.6094063091832;645.9903101453482;802.3019972623825;814.0028465130227;815.5759005317232;816.6896579299857;817.0971076959963;817.5503473089807;862.9913700862974;869.1004810021628;869.326272139094;869.4870026684255;870.277669534285;671.5601281160848;843.2326582809675;859.7377799771067;861.8965724113084;864.6757465950269;628.6825153297556;629.3297638015499;630.9558330916838;632.6109442692757;634.9174607301021;12854.357282135948;12930.28883411412;12933.87066129336;12934.159279646887;12974;12298.508059677602;12783.424745886365;12917.677058073623;12943.19453076445;12979.740405191844;9831.410115393099;9846.556904939294;9853.514072189557;10177.745556361077;10255.282130250886;3335.533025376425;3356.899293021189;3377.510261012164;3416.8974930752115;3462.290230502741;43940.340894886926;44123.558764412264;44148.77925610384;44161.33757993633;44298.778506107585;10053.49732513386;10142.087212150795;10209.642662506776;10437.112845408225;10448.947755261175;18485.134804105386;18492.445226643224;18515.074246287902;18570.721439178422;18587.44237672872;6725.764598239038;6998.650067496605;7011.6494175292055;7082.185548661867;7173.92826071743;3747.213085252073;3766.717496187742;3785.564660064073;3790.5830358660523;3905.179912218466;2802.425502771927;2826.8445235512245;2831.759300459443;2842.573613957923;2848.928776780597;443.7537166872417;503.8110708484318;504.88640055987844;509;543.4402565357609;483.9056384005085;547.8520799384144;620.9037599172135;625.433982246068;638.5127108576837;7811.726589569338;7943.4836735612;8150.266476017068;8175.468594541336;8218.753437396888;616.4975544930867;619.3527763487167;626.3548544998658;635.4344633276388;640.1166390381337;3727.589965103836;3776.169242766587;3785.167263202091;3821.1975485147873;3875.302445559826;52083.73958130185;52389.47610523922;52831;52858.207126893125;52885.47114528882;42404.787976059924;43677.34483982743;44375.89060273519;44620.55379446229;44742.10515789666;36413;36950.26099478049;37029.44455833165;37115.07212319713;37123.25753484915;7781.9610901945125;8084.63619137152;8121.1472795358;8227.71203007892;8351.457155284887;31256.21859453441;31538.684613153575;31762.364752704354;32837.83581082079;33536.66463335433;37566;41123.1775364497;41693.16613667649;41733;42237.155256894075;8947.865782013405;9026.45841249527;9048.592813323285;9093.40892841963;9110.134537218953;10988.505517251902;11079.113670906469;11090.611828585961;11205.159613028893;11290.322580645188;10554.155667546731;10610.734731631772;10746.892531074589;10804.891951080703;10958.28771129874;10318.742031449274;10953.507092181031;11071.612493562687;11117.166212534254;11570.94214528922;10545.736356591147;10660.573577057141;10719.678409647722;10775.51510182028;10794.784104317712;8751.693690720795;8809.471431714117;8972.19250267479;9266.629334826532;9340.486273254764;8822.723718354368;8902.59938302765;8949.149830766068;9319.254459643347;9352.064793520594 22:43:22 INFO - PROCESS | 7752 | __end_tp_report 22:43:22 INFO - PROCESS | 7752 | __start_cc_report 22:43:22 INFO - PROCESS | 7752 | _x_x_mozilla_cycle_collect,880 22:43:22 INFO - PROCESS | 7752 | __end_cc_report 22:43:22 INFO - PROCESS | 7752 | __startTimestamp1459835002320__endTimestamp 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | ------- Summary: start ------- 22:43:22 INFO - PROCESS | 7752 | Number of tests: 6 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#0] dojo.html Cycles:165 Average:4550.84 Median:4685.39 stddev:461.73 (9.9%) stddev-sans-first:436.68 22:43:22 INFO - PROCESS | 7752 | Values: 2586.9 2660.0 2669.0 2678.8 2686.1 4516.5 4547.3 4563.9 4588.4 4594.0 4627.5 4639.4 4661.3 4696.2 4698.1 4191.9 4208.2 4231.1 4259.6 4352.5 4301.4 4311.9 4320.7 4344.3 4358.3 4210.3 4255.3 4258.3 4285.7 4287.9 4195.6 4227.4 4231.9 4232.9 4237.1 4213.1 4216.3 4219.7 4222.2 4222.7 4460.3 4502.8 4522.6 4539.1 4547.8 4860.7 4871.7 4872.1 4880.6 4923.9 4847.5 4901.1 4903.8 4907.1 4940.8 4576.4 4606.1 4607.1 4654.8 4658.2 5014.3 5033.2 5053.8 5055.9 5100.0 4734.3 4797.1 4821.5 4839.0 4891.9 4867.7 4886.7 4901.1 4928.3 4935.0 4824.8 4829.3 4830.3 4835.6 4871.5 4750.2 4812.0 4820.4 4837.9 4873.6 4100.7 4118.8 4135.1 4155.6 4162.3 3610.9 3628.3 3637.4 3663.8 3685.0 4191.6 4258.1 4273.8 4278.4 4289.0 4962.5 4965.1 4968.2 4987.6 5019.8 4291.3 4304.8 4306.1 4306.1 4358.1 4271.8 4345.7 4404.5 4409.0 4411.8 4622.7 4644.1 4645.9 4690.5 4695.7 4900.4 4903.7 4908.9 4918.1 4965.8 4571.7 4663.6 4668.8 4736.0 4748.8 4868.5 4877.2 4899.9 4903.4 4944.6 4947.3 4971.0 4972.8 4974.3 5023.2 4662.1 4748.9 4785.1 4799.4 4834.1 4791.1 4809.6 4826.0 4832.3 4873.1 4597.1 4685.4 4741.6 4749.1 4797.3 4774.2 4804.6 4814.1 4858.2 4861.5 4642.4 4709.5 4712.7 4716.1 4755.7 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#1] ext.html Cycles:180 Average:38808.37 Median:34125.24 stddev:59647.33 (174.8%) stddev-sans-first:59745.36 22:43:22 INFO - PROCESS | 7752 | Values: 516.4 525.9 532.1 535.8 545.6 34223.5 34406.3 34495.8 34506.5 34508.1 38005.6 38223.2 38410.6 38605.8 38728.0 7590.4 7727.5 7750.8 7765.1 7772.3 7592.5 7704.3 7709.9 7722.8 7727.8 7856.5 7911.4 7921.4 7922.3 7927.0 7821.6 7884.6 7893.8 7901.5 7926.6 7895.9 8015.4 8021.2 8022.1 8026.0 38238.2 38681.8 38695.6 38767.0 38777.6 3170.3 3297.5 3317.9 3694.9 3857.2 29205.3 29330.7 29446.4 29465.6 30451.0 3352.5 3368.5 3369.2 3384.6 3491.6 170435.0 170551.0 170623.1 170688.0 170895.0 47663.3 49190.0 58760.7 60184.7 60393.0 52564.6 52629.9 52883.7 52906.0 52917.5 14933.9 15054.5 15164.2 15166.9 15174.2 10155.5 10861.8 10991.1 11006.4 11007.3 18958.3 19000.3 19037.7 19054.8 19103.8 6978.9 7104.9 7105.7 7135.7 7141.5 875.4 897.5 952.3 968.4 1049.6 26858.5 27158.5 27609.6 27746.0 27864.3 937.0 970.8 996.5 1009.7 1153.8 14016.2 14171.7 14270.3 14580.0 14589.6 291895.6 293136.0 294368.0 294988.0 297160.0 48809.8 49261.0 49300.3 49330.5 49350.5 1102.9 1247.2 1265.2 1267.2 1334.7 24558.5 24959.5 26359.5 26914.3 27353.3 38507.2 38811.4 38863.2 38880.6 38951.2 199859.0 202527.0 203020.0 203318.0 203854.0 30181.5 30361.8 31286.7 31331.4 31371.0 38292.0 38691.0 39217.4 39322.2 39352.8 33162.0 33268.3 33391.0 33428.2 33688.8 33171.8 33997.8 34027.0 37979.6 38622.8 33151.5 33365.7 33585.7 34421.8 35131.0 26809.2 27690.0 27717.7 27781.0 27867.2 22357.2 22409.7 22452.8 22899.3 22925.3 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#2] jquery.html Cycles:180 Average:23377.35 Median:24424.77 stddev:64898.63 (265.7%) stddev-sans-first:65057.65 22:43:22 INFO - PROCESS | 7752 | Values: 343.3 355.7 357.4 362.9 367.3 15492.8 15794.8 17096.3 17525.6 17586.8 16352.5 16676.7 16924.3 16963.7 16994.7 4910.2 4974.7 5109.5 5119.2 5120.1 5032.6 5052.9 5062.5 5072.6 5089.4 4996.5 5017.5 5033.8 5044.1 5079.5 4932.6 5026.4 5057.2 5070.6 5072.7 4497.2 4506.0 4510.5 4513.6 4519.9 18847.2 19999.8 20104.7 20131.9 20150.6 1803.6 1935.2 1942.7 2029.6 2152.7 9335.0 9402.9 9723.0 10946.3 12789.7 1757.8 1814.5 1824.2 1830.3 1859.9 59253.0 61474.4 63020.1 63517.7 63637.7 9169.2 9199.0 9584.8 9718.6 9801.0 13429.6 13545.7 13575.7 13597.6 13601.3 7299.2 7347.3 7414.4 7504.9 7506.9 7118.8 7124.4 7132.7 7181.0 7195.5 4276.4 4299.3 4311.8 4324.6 4362.6 1764.9 1792.5 1803.5 1816.4 1824.2 835.5 867.0 875.2 900.7 914.8 15596.9 15660.5 16103.3 16104.3 16142.5 912.0 924.7 930.2 960.5 975.4 6343.0 9116.8 9139.5 9327.7 9427.8 377800.0 396106.0 401076.0 402400.0 403011.0 38394.6 50102.7 62372.7 69112.7 72079.0 901.6 914.7 927.7 929.7 934.5 14098.0 14223.8 14346.4 14512.6 14523.3 30757.4 32979.8 34450.7 35096.5 35157.6 44352.3 46102.8 46151.8 46568.8 46757.5 7209.7 7278.3 7316.3 7333.8 7349.4 8454.8 11844.5 11855.3 11884.9 12074.2 9806.7 9846.6 10029.3 10057.5 10137.2 10211.7 10294.9 10367.2 10447.8 10496.7 10257.8 10487.5 10498.5 10734.0 10755.3 7430.0 7433.6 7433.9 7468.6 7597.1 10209.4 10346.3 10360.0 10399.6 10489.6 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#3] mootools.html Cycles:180 Average:5024.38 Median:6151.77 stddev:2564.69 (41.7%) stddev-sans-first:2557.52 22:43:22 INFO - PROCESS | 7752 | Values: 1412.9 1414.0 1586.7 1731.0 1772.4 7018.2 7211.4 7228.3 7229.6 7235.4 6225.6 6390.6 6392.1 6402.9 7099.6 2109.8 2180.6 2181.4 2181.5 2181.6 2096.4 2103.9 2135.9 2179.6 2181.0 1871.8 2106.3 2147.9 2160.4 2181.6 2106.7 2120.2 2140.7 2150.8 2154.4 2050.3 2076.1 2097.6 2100.4 2101.4 7032.9 7105.3 7110.8 7123.7 7131.7 4483.2 4584.2 4588.6 4594.7 4600.8 2831.5 2883.1 2947.4 2951.9 2997.5 894.5 953.9 959.5 960.9 981.6 9895.2 9919.1 9919.4 9932.9 9952.6 4106.0 4107.4 4177.4 4182.4 4195.6 7578.1 7613.4 7625.9 7640.0 7642.8 4439.7 4440.7 4448.2 4450.1 4452.4 3413.6 3995.2 4104.5 4112.2 4115.0 3209.4 3254.6 3268.8 3272.4 3274.7 974.0 1010.8 1011.8 1018.2 1021.0 993.9 1019.7 1076.5 1209.2 1213.9 6676.2 6709.7 6811.9 6853.2 6859.7 1056.4 1060.9 1063.5 1069.6 1074.8 5365.2 5429.9 5435.7 5466.3 5467.1 8515.1 8550.8 8771.0 8814.0 8829.6 8634.1 8730.5 8763.5 8784.3 8808.8 6781.1 6920.7 6937.0 6973.4 7029.3 6562.8 6581.9 6602.7 6644.5 6661.9 7643.5 7856.7 7860.5 7954.1 7980.4 7884.1 8086.0 8160.0 8177.5 8296.6 5228.1 5867.8 6085.8 6186.3 6197.3 6838.2 6857.5 6859.8 6860.2 6898.0 6146.8 6194.1 6213.1 6262.0 6282.6 5963.5 6051.4 6100.1 6144.9 6171.4 6238.5 6417.8 6418.5 6439.3 6441.0 5990.7 6085.7 6086.1 6090.6 6097.2 6156.8 6171.5 6224.8 6234.0 6236.3 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#4] prototype.html Cycles:180 Average:4668.16 Median:5326.47 stddev:1346.18 (25.3%) stddev-sans-first:1309.65 22:43:22 INFO - PROCESS | 7752 | Values: 312.5 314.1 317.7 320.0 323.4 5234.9 5404.2 5409.7 5425.3 5435.2 5221.8 5310.6 5342.3 5348.7 5356.4 3951.5 4069.7 4147.0 4148.8 4155.0 4189.6 4211.2 4212.7 4221.1 4221.3 4175.3 4179.5 4185.7 4188.3 4196.0 4008.0 4072.7 4172.5 4182.2 4194.3 3695.0 3713.8 3715.6 3717.9 3726.7 5104.4 5112.8 5121.2 5132.0 5133.7 4802.8 4822.8 4831.8 4832.0 4838.5 5590.7 5591.8 5594.0 5608.4 5616.8 4065.2 4067.8 4069.6 4073.1 4082.1 5626.4 5808.2 5855.1 5866.9 5871.7 4144.1 4155.6 4155.6 4158.9 4168.5 4210.9 4215.5 4224.0 4225.2 4227.2 4774.2 4780.9 4781.5 4782.2 4782.9 5591.8 5591.9 5596.1 5602.3 5652.5 1464.5 1487.5 1493.4 1493.6 1495.2 946.4 991.9 1000.3 1007.2 1010.5 4858.7 4927.6 4945.1 5010.1 5012.1 5825.3 5835.5 5840.0 5852.9 5861.8 4994.8 4997.9 5001.4 5002.8 5006.9 3101.4 3119.5 3144.1 3144.3 3148.2 5510.5 5515.0 5515.7 5525.6 5528.1 5753.0 5972.0 5974.3 5987.4 5991.7 5476.5 5493.1 5499.6 5507.8 5511.9 5827.0 5841.5 5865.6 5909.0 5912.7 5625.2 5641.7 5656.4 5708.5 5721.9 5398.6 5415.7 5419.5 5472.6 5503.4 3848.6 3896.8 3899.9 3909.7 3988.4 5642.3 5663.7 5699.7 5704.5 5719.2 5457.4 5459.9 5513.5 5514.7 5520.6 5426.1 5497.4 5502.2 5512.5 5518.0 5424.2 5432.8 5434.3 5437.0 5444.8 5472.5 5655.9 5669.4 5692.9 5693.5 5501.3 5518.4 5539.9 5539.9 5545.5 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - PROCESS | 7752 | [#5] yui.html Cycles:180 Average:12599.11 Median:44136.17 stddev:14121.35 (32.0%) stddev-sans-first:14132.54 22:43:22 INFO - PROCESS | 7752 | Values: 668.6 719.5 747.6 771.9 800.6 12289.0 12292.8 12354.6 12371.4 12376.3 12013.8 12047.8 12080.0 12135.3 12136.5 633.1 645.5 645.6 646.0 802.3 814.0 815.6 816.7 817.1 817.6 863.0 869.1 869.3 869.5 870.3 671.6 843.2 859.7 861.9 864.7 628.7 629.3 631.0 632.6 634.9 12854.4 12930.3 12933.9 12934.2 12974.0 12298.5 12783.4 12917.7 12943.2 12979.7 9831.4 9846.6 9853.5 10177.7 10255.3 3335.5 3356.9 3377.5 3416.9 3462.3 43940.3 44123.6 44148.8 44161.3 44298.8 10053.5 10142.1 10209.6 10437.1 10448.9 18485.1 18492.4 18515.1 18570.7 18587.4 6725.8 6998.7 7011.6 7082.2 7173.9 3747.2 3766.7 3785.6 3790.6 3905.2 2802.4 2826.8 2831.8 2842.6 2848.9 443.8 503.8 504.9 509.0 543.4 483.9 547.9 620.9 625.4 638.5 7811.7 7943.5 8150.3 8175.5 8218.8 616.5 619.4 626.4 635.4 640.1 3727.6 3776.2 3785.2 3821.2 3875.3 52083.7 52389.5 52831.0 52858.2 52885.5 42404.8 43677.3 44375.9 44620.6 44742.1 36413.0 36950.3 37029.4 37115.1 37123.3 7782.0 8084.6 8121.1 8227.7 8351.5 31256.2 31538.7 31762.4 32837.8 33536.7 37566.0 41123.2 41693.2 41733.0 42237.2 8947.9 9026.5 9048.6 9093.4 9110.1 10988.5 11079.1 11090.6 11205.2 11290.3 10554.2 10610.7 10746.9 10804.9 10958.3 10318.7 10953.5 11071.6 11117.2 11570.9 10545.7 10660.6 10719.7 10775.5 10794.8 8751.7 8809.5 8972.2 9266.6 9340.5 8822.7 8902.6 8949.1 9319.3 9352.1 22:43:22 INFO - PROCESS | 7752 | -------- Summary: end -------- 22:43:22 INFO - PROCESS | 7752 | 22:43:22 INFO - TEST-INFO | 7752: exit 0 22:43:22 INFO - TEST-OK | dromaeo_css | took 1116355ms 22:43:22 INFO - TEST-START | kraken 22:43:22 INFO - operating with platform_type : linux_ 22:43:22 INFO - Initialising browser for kraken test... 22:43:22 INFO - TEST-INFO | started process 7933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMAM4C/profile http://localhost:35117/getInfo.html) 22:43:27 INFO - PROCESS | 7933 | __metrics Screen width/height:1600/1200 22:43:27 INFO - PROCESS | 7933 | colorDepth:24 22:43:27 INFO - PROCESS | 7933 | Browser inner width/height: 1024/697 22:43:27 INFO - PROCESS | 7933 | __metrics 22:43:28 ERROR - PROCESS | 7933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:43:29 INFO - TEST-INFO | 7933: exit 0 22:43:29 INFO - Browser initialized. 22:43:29 INFO - Running cycle 1/1 for kraken test... 22:43:29 INFO - TEST-INFO | started process 8016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMAM4C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:40 INFO - PROCESS | 8016 | RSS: Main: 154423296 22:43:40 INFO - PROCESS | 8016 | 22:43:43 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35117/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:44 INFO - PROCESS | 8016 | RSS: Main: 194555904 22:43:44 INFO - PROCESS | 8016 | 22:43:46 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35117/tests/kraken/driver.html?testName=audio-dft) 22:43:47 INFO - PROCESS | 8016 | RSS: Main: 184479744 22:43:47 INFO - PROCESS | 8016 | 22:43:50 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35117/tests/kraken/driver.html?testName=audio-fft) 22:43:51 INFO - PROCESS | 8016 | RSS: Main: 171675648 22:43:51 INFO - PROCESS | 8016 | 22:43:53 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35117/tests/kraken/driver.html?testName=audio-oscillator) 22:43:53 INFO - PROCESS | 8016 | RSS: Main: 171098112 22:43:53 INFO - PROCESS | 8016 | 22:43:56 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:43:56 INFO - PROCESS | 8016 | RSS: Main: 173256704 22:43:56 INFO - PROCESS | 8016 | 22:43:59 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35117/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:00 INFO - PROCESS | 8016 | RSS: Main: 173608960 22:44:00 INFO - PROCESS | 8016 | 22:44:03 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35117/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:04 INFO - PROCESS | 8016 | RSS: Main: 173432832 22:44:04 INFO - PROCESS | 8016 | 22:44:07 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35117/tests/kraken/driver.html?testName=json-parse-financial) 22:44:07 INFO - PROCESS | 8016 | RSS: Main: 174112768 22:44:07 INFO - PROCESS | 8016 | 22:44:09 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:10 INFO - PROCESS | 8016 | RSS: Main: 183480320 22:44:10 INFO - PROCESS | 8016 | 22:44:11 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:12 INFO - PROCESS | 8016 | RSS: Main: 182398976 22:44:12 INFO - PROCESS | 8016 | 22:44:14 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:15 INFO - PROCESS | 8016 | RSS: Main: 190545920 22:44:15 INFO - PROCESS | 8016 | 22:44:17 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:18 INFO - PROCESS | 8016 | RSS: Main: 197111808 22:44:18 INFO - PROCESS | 8016 | 22:44:20 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:21 INFO - PROCESS | 8016 | RSS: Main: 196976640 22:44:21 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | Cycle 1(1): loaded http://localhost:35117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35117/tests/kraken/driver.html?testName=ai-astar) 22:44:23 INFO - PROCESS | 8016 | RSS: Main: 258777088 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | __start_tp_report 22:44:23 INFO - PROCESS | 8016 | _x_x_mozilla_page_load 22:44:23 INFO - PROCESS | 8016 | _x_x_mozilla_page_load_details 22:44:23 INFO - PROCESS | 8016 | |i|pagename|runs| 22:44:23 INFO - PROCESS | 8016 | |0;ai-astar;110;114;107;112;112;113;101;113;110;114 22:44:23 INFO - PROCESS | 8016 | |1;audio-beat-detection;162;132;157;176;134;163;162;134;168;133 22:44:23 INFO - PROCESS | 8016 | |2;audio-dft;160;161;161;162;161;160;161;161;160;162 22:44:23 INFO - PROCESS | 8016 | |3;audio-fft;74;77;98;96;78;73;74;115;102;74 22:44:23 INFO - PROCESS | 8016 | |4;audio-oscillator;94;93;144;95;92;94;140;95;93;146 22:44:23 INFO - PROCESS | 8016 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 22:44:23 INFO - PROCESS | 8016 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;146;147 22:44:23 INFO - PROCESS | 8016 | |7;imaging-desaturate;95;94;95;95;95;95;96;95;95;95 22:44:23 INFO - PROCESS | 8016 | |8;json-parse-financial;64;65;64;66;65;66;65;74;63;64 22:44:23 INFO - PROCESS | 8016 | |9;json-stringify-tinderbox;63;63;64;64;65;63;64;65;69;64 22:44:23 INFO - PROCESS | 8016 | |10;stanford-crypto-aes;80;83;83;81;85;81;96;82;82;82 22:44:23 INFO - PROCESS | 8016 | |11;stanford-crypto-ccm;117;118;121;115;117;115;124;118;116;125 22:44:23 INFO - PROCESS | 8016 | |12;stanford-crypto-pbkdf2;139;128;134;141;156;132;137;146;137;138 22:44:23 INFO - PROCESS | 8016 | |13;stanford-crypto-sha256-iterative;67;73;69;69;67;66;69;68;66;65 22:44:23 INFO - PROCESS | 8016 | __end_tp_report 22:44:23 INFO - PROCESS | 8016 | __start_cc_report 22:44:23 INFO - PROCESS | 8016 | _x_x_mozilla_cycle_collect,1161 22:44:23 INFO - PROCESS | 8016 | __end_cc_report 22:44:23 INFO - PROCESS | 8016 | __startTimestamp1459835063433__endTimestamp 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | ------- Summary: start ------- 22:44:23 INFO - PROCESS | 8016 | Number of tests: 14 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 22:44:23 INFO - PROCESS | 8016 | Values: 110.0 114.0 107.0 112.0 112.0 113.0 101.0 113.0 110.0 114.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:162.00 stddev:16.95 (10.5%) stddev-sans-first:17.60 22:44:23 INFO - PROCESS | 8016 | Values: 162.0 132.0 157.0 176.0 134.0 163.0 162.0 134.0 168.0 133.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:44:23 INFO - PROCESS | 8016 | Values: 160.0 161.0 161.0 162.0 161.0 160.0 161.0 161.0 160.0 162.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#3] audio-fft Cycles:10 Average:86.10 Median:75.50 stddev:15.23 (20.2%) stddev-sans-first:15.51 22:44:23 INFO - PROCESS | 8016 | Values: 74.0 77.0 98.0 96.0 78.0 73.0 74.0 115.0 102.0 74.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.50 stddev:24.03 (25.7%) stddev-sans-first:24.90 22:44:23 INFO - PROCESS | 8016 | Values: 94.0 93.0 144.0 95.0 92.0 94.0 140.0 95.0 93.0 146.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:44:23 INFO - PROCESS | 8016 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:44:23 INFO - PROCESS | 8016 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:44:23 INFO - PROCESS | 8016 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.10 (4.8%) stddev-sans-first:3.23 22:44:23 INFO - PROCESS | 8016 | Values: 64.0 65.0 64.0 66.0 65.0 66.0 65.0 74.0 63.0 64.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:1.78 (2.8%) stddev-sans-first:1.81 22:44:23 INFO - PROCESS | 8016 | Values: 63.0 63.0 64.0 64.0 65.0 63.0 64.0 65.0 69.0 64.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:4.60 (5.6%) stddev-sans-first:4.70 22:44:23 INFO - PROCESS | 8016 | Values: 80.0 83.0 83.0 81.0 85.0 81.0 96.0 82.0 82.0 82.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.00 stddev:3.57 (3.0%) stddev-sans-first:3.73 22:44:23 INFO - PROCESS | 8016 | Values: 117.0 118.0 121.0 115.0 117.0 115.0 124.0 118.0 116.0 125.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:138.50 stddev:7.79 (5.6%) stddev-sans-first:8.26 22:44:23 INFO - PROCESS | 8016 | Values: 139.0 128.0 134.0 141.0 156.0 132.0 137.0 146.0 137.0 138.0 22:44:23 INFO - PROCESS | 8016 | 22:44:23 INFO - PROCESS | 8016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:2.28 (3.3%) stddev-sans-first:2.40 22:44:23 INFO - PROCESS | 8016 | Values: 67.0 73.0 69.0 69.0 67.0 66.0 69.0 68.0 66.0 65.0 22:44:23 INFO - PROCESS | 8016 | -------- Summary: end -------- 22:44:23 INFO - PROCESS | 8016 | 22:44:24 INFO - TEST-INFO | 8016: exit 0 22:44:24 INFO - TEST-OK | kraken | took 61367ms 22:44:24 INFO - SUITE-END | took 1177s 22:44:24 INFO - Completed test suite (00:19:37) 22:44:24 INFO - javascript benchmark 22:44:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2586.883590238439, 2660.042384741494, 2668.9733102668965, 2678.7990900682453, 2686.113582517769, 4516.480604730457, 4547.295169248768, 4563.88590285243, 4588.403507544019, 4594.0, 4627.490975992638, 4639.373684552585, 4661.254199328099, 4696.248600223965, 4698.130845793522, 4191.874243772691, 4208.158368326332, 4231.090315582149, 4259.6379307758725, 4352.477702675684, 4301.440812694361, 4311.935320970188, 4320.65434765218, 4344.283193273106, 4358.3244597087505, 4210.305299625558, 4255.2978758504805, 4258.254805409041, 4285.657147428198, 4287.935680964788, 4195.55946625603, 4227.4292970448905, 4231.915361692749, 4232.936505952413, 4237.089025859455, 4213.115245798386, 4216.325387937946, 4219.725717828362, 4222.1555688862045, 4222.683298752575, 4460.30865215892, 4502.842400515966, 4522.570355816192, 4539.137563862855, 4547.818087276505, 4860.659753817235, 4871.658983871131, 4872.123017856784, 4880.585150262232, 4923.852284431473, 4847.466778654345, 4901.09329773993, 4903.779329930162, 4907.141250281186, 4940.752962351868, 4576.3821884045565, 4606.055758569485, 4607.101615185074, 4654.767261636905, 4658.231391820379, 5014.34813474246, 5033.245013248042, 5053.772580233898, 5055.949440505621, 5099.974500127476, 4734.313524538991, 4797.136515427256, 4821.5178482152205, 4838.975805120952, 4891.926621100686, 4867.6836005660225, 4886.65793394459, 4901.142300097468, 4928.28539861718, 4934.963657631937, 4824.807007719722, 4829.275608658659, 4830.3237546743485, 4835.588974937099, 4871.464138944713, 4750.239961606127, 4811.9518804811505, 4820.421549414093, 4837.927431088537, 4873.634477414208, 4100.671946244293, 4118.75287482752, 4135.0902801383645, 4155.625993660585, 4162.271602469556, 3610.945835812465, 3628.32875917956, 3637.3634613942454, 3663.780173189617, 3685.023468780775, 4191.622753952159, 4258.127083947783, 4273.786310684453, 4278.358246263086, 4289.0, 4962.528559786814, 4965.081459929852, 4968.155413579628, 4987.600991920638, 5019.799208031711, 4291.270484017725, 4304.80628371724, 4306.1172459645695, 4306.138772245564, 4358.084802191575, 4271.765052922119, 4345.717528360647, 4404.537523560044, 4409.007973206003, 4411.801468933906, 4622.722636641813, 4644.094401591725, 4645.883852903705, 4690.530946905282, 4695.671303008757, 4900.411950565955, 4903.681260718042, 4908.852734417973, 4918.1393256180745, 4965.776540055778, 4571.657125715651, 4663.603593694574, 4668.766561671835, 4735.981763920774, 4748.833790817304, 4868.537488938545, 4877.195262781602, 4899.926501102557, 4903.387076615423, 4944.604431645388, 4947.2579113133315, 4971.0, 4972.7762250699525, 4974.32846565709, 5023.246513023076, 4662.137504561667, 4748.9050218994735, 4785.138675038526, 4799.3760811094335, 4834.129856625841, 4791.113643975876, 4809.615230781599, 4825.9758701207675, 4832.275158726219, 4873.074115917964, 4597.149527337453, 4685.390899183084, 4741.57325840676, 4749.145153872336, 4797.328374027708, 4774.21225497789, 4804.591609713214, 4814.085323788469, 4858.198397264412, 4861.51384861511, 4642.350070990132, 4709.481956984798, 4712.740799256074, 4716.127516409475, 4755.667103302736], "unit": "score", "name": "dojo.html", "value": 4522.637446395758}, {"lowerIsBetter": false, "replicates": [516.3571353664687, 525.9132243179876, 532.1352801697242, 535.7803300646735, 545.5799034743245, 34223.48664770027, 34406.31187376251, 34495.82752086239, 34506.48240276398, 34508.1372965676, 38005.61994380056, 38223.23553528928, 38410.61589384105, 38605.806970965175, 38728.0, 7590.392768578514, 7727.49771264866, 7750.8449831003345, 7765.107012693527, 7772.3393511551585, 7592.50648707835, 7704.306612404883, 7709.922900770976, 7722.8455430891345, 7727.806804829868, 7856.450048496607, 7911.446198766089, 7921.445498815086, 7922.326602238817, 7927.0, 7821.569813660247, 7884.566348850783, 7893.763187104396, 7901.486403383762, 7926.564038977854, 7895.881561776578, 8015.358771298283, 8021.237982391722, 8022.1175670676175, 8025.95987020067, 38238.23523529542, 38681.806590966866, 38695.61304386948, 38767.03082422962, 38777.61222387768, 3170.3183815479783, 3297.505374193866, 3317.8672853085845, 3694.8522059117604, 3857.1707082977014, 29205.26986825325, 29330.706692933225, 29446.411071778657, 29465.558016629766, 30451.0, 3352.4803655433448, 3368.456646162882, 3369.241920567877, 3384.5769278840144, 3491.6159222485508, 170435.0, 170551.0, 170623.14688426603, 170688.0, 170895.0, 47663.28505072427, 49190.0, 58760.706196468745, 60184.69907650434, 60393.0, 52564.63459144348, 52629.894964179344, 52883.735581321846, 52906.0, 52917.47082529125, 14933.850661493463, 15054.473093441677, 15164.165970871487, 15166.924165379103, 15174.165420901956, 10155.492225388702, 10861.83707244392, 10991.120710343313, 11006.394648294421, 11007.284526505751, 18958.336458223897, 19000.334988275343, 19037.714434283498, 19054.80945190558, 19103.808961910203, 6978.930210697929, 7104.928950710427, 7105.71577136919, 7135.678894449762, 7141.500094993301, 875.4309698695898, 897.4615230861431, 952.2619969523536, 968.3947532792005, 1049.5644307612408, 26858.462830743665, 27158.456830863273, 27609.585856212172, 27746.02888898879, 27864.303392414946, 936.990630093704, 970.84466485362, 996.5017491254373, 1009.7122320138725, 1153.7807816514835, 14016.229107399191, 14171.716565668836, 14270.286485675675, 14580.0, 14589.635259118608, 291895.56731029047, 293136.0, 294368.0, 294988.0, 297160.0, 48809.75595122073, 49261.0, 49300.26049609259, 49330.50669493331, 49350.50649493459, 1102.9007389334997, 1247.2454165230088, 1265.2092442223611, 1267.1573403686814, 1334.7130366970953, 24558.508829823662, 24959.500809984063, 26359.472810544066, 26914.32714182161, 27353.31616709598, 38507.2298554033, 38811.417828732025, 38863.222735544565, 38880.6111938877, 38951.220975580894, 199859.0, 202527.0, 203020.0, 203318.0, 203854.0, 30181.547276790425, 30361.848190758905, 31286.68713312929, 31331.37337253288, 31371.0, 38292.0, 38691.03272418212, 39217.41173882337, 39322.2135557293, 39352.803235984786, 33162.0, 33268.334633307684, 33391.0, 33428.1642958928, 33688.831555842065, 33171.83414082914, 33997.830010849786, 34027.0, 37979.62020379761, 38622.80688596539, 33151.50272745959, 33365.66634333723, 33585.664143358255, 34421.82789086038, 35131.0, 26809.19572412831, 27690.0, 27717.72282277232, 27781.0, 27867.16398508048, 22357.21749738751, 22409.66385504186, 22452.77547224507, 22899.31302060941, 22925.312240632808], "unit": "score", "name": "ext.html", "value": 16801.70322051412}, {"lowerIsBetter": false, "replicates": [343.3167995688581, 355.7100962715387, 357.4013527341703, 362.9346717590834, 367.34612389945875, 15492.845071549295, 15794.763078553817, 17096.316147354122, 17525.649487010283, 17586.82413175868, 16352.509424717247, 16676.66646667066, 16924.323027078903, 16963.660726785456, 16994.7450788238, 4910.1898186799135, 4974.676646018006, 5109.514596113382, 5119.155339368999, 5120.0527902338, 5032.6477146599755, 5052.9242061369105, 5062.468440813716, 5072.644914855961, 5089.3638295213095, 4996.4503904570465, 5017.498250174972, 5033.823816166435, 5044.142495775727, 5079.492050794928, 4932.556069953704, 5026.396832380138, 5057.165567681328, 5070.619703522232, 5072.670276432039, 4497.212987727167, 4505.977470112662, 4510.481294651091, 4513.571210735008, 4519.909601807945, 18847.24611015558, 19999.800001999938, 20104.69842952357, 20131.899340503205, 20150.596988060304, 1803.6122233719682, 1935.1775495414392, 1942.7085937109405, 2029.6346657601625, 2152.7309086364203, 9334.953051409446, 9402.858957115648, 9722.951385243028, 10946.288491248044, 12789.744205115938, 1757.8417942385247, 1814.5191524246086, 1824.2155872974615, 1830.3227805711838, 1859.907004649762, 59253.0, 61474.38525614731, 63020.05469917955, 63517.682411587644, 63637.68181159111, 9169.220616247694, 9198.95400522993, 9584.76038099053, 9718.562664680107, 9800.950995244979, 13429.597112086652, 13545.661358466117, 13575.66060848467, 13597.592072237849, 13601.31993400326, 7299.233580473974, 7347.338739513362, 7414.369778568882, 7504.924950750423, 7506.887396689054, 7118.750843720549, 7124.43004559634, 7132.679029443688, 7180.9640951795955, 7195.532290401107, 4276.35854621803, 4299.269124248885, 4311.827526898952, 4324.589164029412, 4362.629176519968, 1764.8941063536229, 1792.4891405949243, 1803.4860064881445, 1816.4187460012934, 1824.1882362348892, 835.4945258118872, 867.0029466113893, 875.2035647560689, 900.6667533012827, 914.8033172867865, 15596.92201538985, 15660.530184094496, 16103.275352608927, 16104.275307611186, 16142.515724528283, 911.9544022798833, 924.7087167542203, 930.2046750028763, 960.481340076351, 975.4196253229317, 6343.0, 9116.81766364669, 9139.497327647043, 9327.720168394959, 9427.811443771086, 377800.0, 396106.0, 401076.0, 402400.0, 403011.0, 38394.616053839665, 50102.74948625234, 62372.68813655902, 69112.65443672749, 72079.0, 901.5627420700955, 914.6661468564059, 927.7309580221795, 929.707142250189, 934.509382574154, 14098.0, 14223.786643200567, 14346.426142954166, 14512.63718407006, 14523.273836307932, 30757.384852303276, 32979.83510082434, 34450.65549344474, 35096.47355289622, 35157.648423515435, 44352.33471497866, 46102.769486152356, 46151.76924115358, 46568.767156165355, 46757.532424675315, 7209.747658832125, 7278.272172782679, 7316.268373162641, 7333.779986600411, 7349.412047036118, 8454.830903381775, 11844.466998984894, 11855.288682678722, 11884.881151188378, 12074.215176013531, 9806.705798826046, 9846.556904939152, 10029.29794914349, 10057.497125143567, 10137.189024877845, 10211.693649190536, 10294.948525257325, 10367.222458315808, 10447.84328235062, 10496.737581560217, 10257.846132307872, 10487.475626218811, 10498.475076246004, 10734.0, 10755.300905441121, 7430.0, 7433.553986760811, 7433.9256607433235, 7468.626568671653, 7597.088349397886, 10209.438480883622, 10346.275760696679, 10360.0, 10399.58401663925, 10489.580416783243], "unit": "score", "name": "jquery.html", "value": 7958.347581015594}, {"lowerIsBetter": false, "replicates": [1412.8940329475288, 1413.978790318145, 1586.6509367939057, 1731.0, 1772.3885259585438, 7018.192907815596, 7211.423086153109, 7228.313310235532, 7229.602371869545, 7235.38499227565, 6225.564210505267, 6390.55266131371, 6392.105105285252, 6402.935970640292, 7099.609521476316, 2109.820665243456, 2180.6292930201826, 2181.4328274648547, 2181.5418762059985, 2181.6291230490774, 2096.423483542023, 2103.852730308879, 2135.9252426165085, 2179.607670619288, 2181.0403422494132, 1871.7753869535675, 2106.3365040012345, 2147.871127732341, 2160.362693005567, 2181.6182168120517, 2106.6945292932514, 2120.183729264229, 2140.668196429556, 2150.7526634437004, 2154.3644624835556, 2050.2516581447812, 2076.09689784944, 2097.590969760897, 2100.432883121564, 2101.443117573844, 7032.859342813115, 7105.253948335402, 7110.786676399716, 7123.679434425463, 7131.67907444161, 4483.215437298492, 4584.243599806028, 4588.609968152711, 4594.724316541018, 4600.769961501912, 2831.490331740286, 2883.063004523517, 2947.410517896408, 2951.8819247230085, 2997.5054116070824, 894.4543828264754, 953.8664586957832, 959.4770849886828, 960.9237653827757, 981.5681100315838, 9895.158911492532, 9919.107280344731, 9919.404835709809, 9932.90067099327, 9952.601895924226, 4105.97947010263, 4107.404426358161, 4177.415161877339, 4182.435371224907, 4195.601417865298, 7578.052743407075, 7613.352865006425, 7625.885611715828, 7640.044994375703, 7642.8089297768, 4439.689221754511, 4440.711353761995, 4448.243798554189, 4450.087732014929, 4452.443444569429, 3413.6245013048547, 3995.180987897474, 4104.486939132608, 4112.239235741397, 4115.0, 3209.422303985258, 3254.6094468663914, 3268.7875288106197, 3272.4273252180774, 3274.6889045540634, 974.0, 1010.8433192855119, 1011.7723512209694, 1018.221060888421, 1021.0198209718753, 993.9453330066916, 1019.6737044145802, 1076.5478499030426, 1209.195884736658, 1213.878612138779, 6676.198856137295, 6709.664516774239, 6811.863762724718, 6853.17761868569, 6859.657017149123, 1056.4084112896649, 1060.9151267898549, 1063.4629512096496, 1069.550788668761, 1074.7581794096423, 5365.22204280385, 5429.945700542944, 5435.701036442954, 5466.316710411199, 5467.097928841697, 8515.063343032261, 8550.78623034429, 8771.03518612952, 8813.955930220307, 8829.558522074, 8634.093420190915, 8730.519821409756, 8763.474191548528, 8784.341174411944, 8808.823823523622, 6781.084553585203, 6920.650473157787, 6937.0, 6973.407260382823, 7029.26192749754, 6562.8359291018105, 6581.934180658323, 6602.702878370389, 6644.501662375438, 6661.933380666132, 7643.503172293783, 7856.7250146244605, 7860.528368297921, 7954.08528019262, 7980.401469889665, 7884.132745398117, 8086.0, 8159.959200203961, 8177.4684645497855, 8296.626651800803, 5228.137357335997, 5867.794627188028, 6085.756569737161, 6186.257649082139, 6197.349278325711, 6838.213605435439, 6857.451403887777, 6859.794206173823, 6860.176778786577, 6898.034275201376, 6146.754129834935, 6194.0708893666315, 6213.099100630474, 6261.96869015652, 6282.623042617458, 5963.493103086286, 6051.364606716407, 6100.1154832548145, 6144.877102457836, 6171.352008039091, 6238.500919926304, 6417.807465776034, 6418.454431373386, 6439.291677915519, 6441.033844923299, 5990.7004649768205, 6085.665288409003, 6086.087086936818, 6090.573659843945, 6097.237845269341, 6156.78451254204, 6171.506279497719, 6224.813255602339, 6234.0, 6236.251649802053], "unit": "score", "name": "mootools.html", "value": 4155.0276244602555}, {"lowerIsBetter": false, "replicates": [312.5296428874544, 314.0797463432143, 317.74739082429465, 319.98240096794683, 323.3936369307548, 5234.895302093956, 5404.162354835002, 5409.729513524318, 5425.2675888755, 5435.157550579662, 5221.817236396727, 5310.62825602208, 5342.305500284967, 5348.732563371836, 5356.437574054727, 3951.486306780115, 4069.6540794032544, 4146.979265103678, 4148.792560371984, 4155.044339801847, 4189.622933935945, 4211.157768446307, 4212.6629869610515, 4221.113566151096, 4221.282381995068, 4175.31107367284, 4179.498460184782, 4185.727927684706, 4188.329867221245, 4196.0, 4008.038070863001, 4072.6945479089186, 4172.520160181557, 4182.22628813669, 4194.328907374836, 3694.963050369489, 3713.755891776258, 3715.5727091384297, 3717.8512859485586, 3726.720495962814, 5104.387473503166, 5112.769925353368, 5121.180611102206, 5132.0249152661245, 5133.6919784813035, 4802.807887684488, 4822.831200907986, 4831.758412079382, 4832.033593281322, 4838.467768545493, 5590.720463976785, 5591.804286849941, 5594.049011668027, 5608.355039170507, 5616.764311851386, 4065.2072845795083, 4067.796610169509, 4069.552349241581, 4073.083556199861, 4082.0611259410502, 5626.352969408529, 5808.186853840466, 5855.121731740231, 5866.941330586682, 5871.706414679292, 4144.109016561454, 4155.58444155582, 4155.646770024521, 4158.854440094582, 4168.499780026416, 4210.936835947463, 4215.515215750167, 4223.97888010558, 4225.176090662353, 4227.217964676544, 4774.21225497789, 4780.856574302777, 4781.52184781526, 4782.187028205213, 4782.928256076161, 5591.804286849941, 5591.860203494945, 5596.104623260258, 5602.327720673464, 5652.547796176378, 1464.531349968, 1487.5016869348674, 1493.3653197391066, 1493.626593351662, 1495.244901324824, 946.3895787217344, 991.8809742830906, 1000.3247807729899, 1007.2093406675724, 1010.4695035106628, 4858.65989380747, 4927.610109097085, 4945.109880221523, 5010.098182327216, 5012.097822392005, 5825.330087040044, 5835.4748072673665, 5840.0, 5852.94147058524, 5861.824145275648, 4994.750262486861, 4997.925031124536, 5001.374828146481, 5002.824901128443, 5006.924896126561, 3101.41073196092, 3119.516474946387, 3144.1039303798307, 3144.292534179837, 3148.197209711509, 5510.476504732044, 5515.034868897927, 5515.669059856422, 5525.613207075547, 5528.087865502147, 5752.971235143881, 5972.044472884318, 5974.3428222895445, 5987.395482964924, 5991.700414979234, 5476.452354764571, 5493.121100623881, 5499.587530935116, 5507.779688812483, 5511.889762204733, 5826.980278451339, 5841.474267315962, 5865.648061116347, 5908.970455147697, 5912.674802885883, 5625.212470254086, 5641.746121424628, 5656.43435656431, 5708.4862362387585, 5721.914171287517, 5398.64908780928, 5415.729213539386, 5419.458054194549, 5472.616916815785, 5503.422140675171, 3848.5766565677195, 3896.805159742058, 3899.9220015600094, 3909.7263191576317, 3988.4216788566077, 5642.266505354278, 5663.7451314690115, 5699.715014249354, 5704.486596206361, 5719.170720245458, 5457.426970168234, 5459.918101228564, 5513.531349835309, 5514.6691198528215, 5520.585956053232, 5426.077566813572, 5497.422770609189, 5502.174673798802, 5512.503874651301, 5517.972410137923, 5424.213489044146, 5432.809851655173, 5434.2935418395355, 5437.02133615953, 5444.782208711607, 5472.452754724655, 5655.886882262414, 5669.433056694297, 5692.914606280826, 5693.4875861172695, 5501.284832971688, 5518.420565840529, 5539.8892022158525, 5539.8892022158525, 5545.473180047889], "unit": "score", "name": "prototype.html", "value": 4239.590248979186}, {"lowerIsBetter": false, "replicates": [668.6155460610149, 719.4639993205063, 747.6448686873736, 771.8880762289465, 800.5676934455395, 12289.0, 12292.815607765868, 12354.567590134347, 12371.381430928452, 12376.257424554533, 12013.819792703116, 12047.759044819099, 12080.0, 12135.271883686984, 12136.514539418435, 633.1041576169725, 645.4707140145083, 645.6094063091832, 645.9903101453482, 802.3019972623825, 814.0028465130227, 815.5759005317232, 816.6896579299857, 817.0971076959963, 817.5503473089807, 862.9913700862974, 869.1004810021628, 869.326272139094, 869.4870026684255, 870.277669534285, 671.5601281160848, 843.2326582809675, 859.7377799771067, 861.8965724113084, 864.6757465950269, 628.6825153297556, 629.3297638015499, 630.9558330916838, 632.6109442692757, 634.9174607301021, 12854.357282135948, 12930.28883411412, 12933.87066129336, 12934.159279646887, 12974.0, 12298.508059677602, 12783.424745886365, 12917.677058073623, 12943.19453076445, 12979.740405191844, 9831.410115393099, 9846.556904939294, 9853.514072189557, 10177.745556361077, 10255.282130250886, 3335.533025376425, 3356.899293021189, 3377.510261012164, 3416.8974930752115, 3462.290230502741, 43940.340894886926, 44123.558764412264, 44148.77925610384, 44161.33757993633, 44298.778506107585, 10053.49732513386, 10142.087212150795, 10209.642662506776, 10437.112845408225, 10448.947755261175, 18485.134804105386, 18492.445226643224, 18515.074246287902, 18570.721439178422, 18587.44237672872, 6725.764598239038, 6998.650067496605, 7011.6494175292055, 7082.185548661867, 7173.92826071743, 3747.213085252073, 3766.717496187742, 3785.564660064073, 3790.5830358660523, 3905.179912218466, 2802.425502771927, 2826.8445235512245, 2831.759300459443, 2842.573613957923, 2848.928776780597, 443.7537166872417, 503.8110708484318, 504.88640055987844, 509.0, 543.4402565357609, 483.9056384005085, 547.8520799384144, 620.9037599172135, 625.433982246068, 638.5127108576837, 7811.726589569338, 7943.4836735612, 8150.266476017068, 8175.468594541336, 8218.753437396888, 616.4975544930867, 619.3527763487167, 626.3548544998658, 635.4344633276388, 640.1166390381337, 3727.589965103836, 3776.169242766587, 3785.167263202091, 3821.1975485147873, 3875.302445559826, 52083.73958130185, 52389.47610523922, 52831.0, 52858.207126893125, 52885.47114528882, 42404.787976059924, 43677.34483982743, 44375.89060273519, 44620.55379446229, 44742.10515789666, 36413.0, 36950.26099478049, 37029.44455833165, 37115.07212319713, 37123.25753484915, 7781.9610901945125, 8084.63619137152, 8121.1472795358, 8227.71203007892, 8351.457155284887, 31256.21859453441, 31538.684613153575, 31762.364752704354, 32837.83581082079, 33536.66463335433, 37566.0, 41123.1775364497, 41693.16613667649, 41733.0, 42237.155256894075, 8947.865782013405, 9026.45841249527, 9048.592813323285, 9093.40892841963, 9110.134537218953, 10988.505517251902, 11079.113670906469, 11090.611828585961, 11205.159613028893, 11290.322580645188, 10554.155667546731, 10610.734731631772, 10746.892531074589, 10804.891951080703, 10958.28771129874, 10318.742031449274, 10953.507092181031, 11071.612493562687, 11117.166212534254, 11570.94214528922, 10545.736356591147, 10660.573577057141, 10719.678409647722, 10775.51510182028, 10794.784104317712, 8751.693690720795, 8809.471431714117, 8972.19250267479, 9266.629334826532, 9340.486273254764, 8822.723718354368, 8902.59938302765, 8949.149830766068, 9319.254459643347, 9352.064793520594], "unit": "score", "name": "yui.html", "value": 5887.17952731984}], "name": "dromaeo_css", "value": 6303.321695100771}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 112.0, 112.0, 113.0, 101.0, 113.0, 110.0, 114.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [162.0, 132.0, 157.0, 176.0, 134.0, 163.0, 162.0, 134.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 98.0, 96.0, 78.0, 73.0, 74.0, 115.0, 102.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 144.0, 95.0, 92.0, 94.0, 140.0, 95.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 63.0, 64.0, 65.0, 69.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 83.0, 81.0, 85.0, 81.0, 96.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 121.0, 115.0, 117.0, 115.0, 124.0, 118.0, 116.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 134.0, 141.0, 156.0, 132.0, 137.0, 146.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 69.0, 69.0, 67.0, 66.0, 69.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1515.3}]} 22:44:24 INFO - Return code: 0 22:44:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:44:24 ERROR - # TBPL SUCCESS # 22:44:24 INFO - Running post-action listener: _resource_record_post_action 22:44:24 INFO - Running post-run listener: _resource_record_post_run 22:44:25 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518795264; Read time: 16; Write time: 449992 22:44:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232837120; Read time: 0; Write time: 217204 22:44:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285958144; Read time: 16; Write time: 232788 22:44:25 INFO - Running post-run listener: _upload_blobber_files 22:44:25 INFO - Blob upload gear active. 22:44:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:25 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 22:44:25 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:44:25 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:44:26 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:44:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:26 INFO - (blobuploader) - INFO - Done attempting. 22:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:27 INFO - (blobuploader) - INFO - Done attempting. 22:44:27 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:28 INFO - Return code: 0 22:44:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9f7f51c93ba5b20f06ae8a6ba745f753a28c67ac9793ee815c8b34f044733feb71c4b9042e51167aa4b0ebaf6fa84771c7ce4ddf66c38d5e5ab03cfba5f69d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62eaa5c003d59f027c8a8118284cca693c3edeaa8b67c6a265a7a4927bdf4a57c88ed022f4a136e421c8eec79da2d106ce1ecf28dc42d02c482bc381a159eb11"} 22:44:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:28 INFO - Contents: 22:44:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9f7f51c93ba5b20f06ae8a6ba745f753a28c67ac9793ee815c8b34f044733feb71c4b9042e51167aa4b0ebaf6fa84771c7ce4ddf66c38d5e5ab03cfba5f69d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62eaa5c003d59f027c8a8118284cca693c3edeaa8b67c6a265a7a4927bdf4a57c88ed022f4a136e421c8eec79da2d106ce1ecf28dc42d02c482bc381a159eb11"} 22:44:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:28 INFO - Copying logs to upload dir... 22:44:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.088417 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-04 22:44:27.695131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:44:27.699080) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9f7f51c93ba5b20f06ae8a6ba745f753a28c67ac9793ee815c8b34f044733feb71c4b9042e51167aa4b0ebaf6fa84771c7ce4ddf66c38d5e5ab03cfba5f69d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62eaa5c003d59f027c8a8118284cca693c3edeaa8b67c6a265a7a4927bdf4a57c88ed022f4a136e421c8eec79da2d106ce1ecf28dc42d02c482bc381a159eb11"} build_url:https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/ZLnNJtgVRryR6esfPrKBTA/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/Fx-Team-Non-PGO/sha512/d9f7f51c93ba5b20f06ae8a6ba745f753a28c67ac9793ee815c8b34f044733feb71c4b9042e51167aa4b0ebaf6fa84771c7ce4ddf66c38d5e5ab03cfba5f69d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62eaa5c003d59f027c8a8118284cca693c3edeaa8b67c6a265a7a4927bdf4a57c88ed022f4a136e421c8eec79da2d106ce1ecf28dc42d02c482bc381a159eb11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:44:27.728054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:44:27.728404) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1459833829.522029-742551576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:44:27.813476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:44:27.814275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:44:27.814946) ========= ========= Total master_lag: 2.75 =========