builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1458845265.32 results: success (0) buildid: 20160324104957 builduid: b8d190aed2474d2cadeaecad5b38da11 revision: 5a437d55565701acfa66934ebcbefb4212c458a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:45.323114) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:45.323595) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:45.323881) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006309 basedir: '/builds/slave/test' ========= master_lag: 0.16 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:45.493518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:45.493820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.384970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.385411) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.547542) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.547839) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.548186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:46.548474) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 11:47:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-03-24 11:47:48 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.598492 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:47.240842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:47.241152) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019337 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:47.457316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 11:47:47.457701) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a437d55565701acfa66934ebcbefb4212c458a4 --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 5a437d55565701acfa66934ebcbefb4212c458a4 --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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 11:47:48,436 truncating revision to first 12 chars 2016-03-24 11:47:48,436 Setting DEBUG logging. 2016-03-24 11:47:48,436 attempt 1/10 2016-03-24 11:47:48,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a437d555657?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 11:47:49,802 unpacking tar archive at: fx-team-5a437d555657/testing/mozharness/ program finished with exit code 0 elapsedTime=1.843352 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 11:47:49.397149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-24 11:47:49.397612) ========= echo 5a437d55565701acfa66934ebcbefb4212c458a4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5a437d55565701acfa66934ebcbefb4212c458a4'] 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5a437d55565701acfa66934ebcbefb4212c458a4 program finished with exit code 0 elapsedTime=0.004726 script_repo_revision: '5a437d55565701acfa66934ebcbefb4212c458a4' ========= master_lag: 1.48 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-24 11:47:50.886478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:50.886744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 11:47:51.214089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-24 11:47:51.214509) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:47:52 INFO - MultiFileLogger online at 20160324 11:47:52 in /builds/slave/test 11:47:52 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 11:47:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:52 INFO - {'append_to_log': False, 11:47:52 INFO - 'base_work_dir': '/builds/slave/test', 11:47:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:47:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:52 INFO - 'branch': 'Fx-Team-Non-PGO', 11:47:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:52 INFO - 'config_files': ('talos/linux_config.py',), 11:47:52 INFO - 'default_actions': ('clobber', 11:47:52 INFO - 'read-buildbot-config', 11:47:52 INFO - 'download-and-extract', 11:47:52 INFO - 'populate-webroot', 11:47:52 INFO - 'create-virtualenv', 11:47:52 INFO - 'install', 11:47:52 INFO - 'run-tests'), 11:47:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:52 INFO - 'download_minidump_stackwalk': True, 11:47:52 INFO - 'download_symbols': 'ondemand', 11:47:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:47:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:47:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:47:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:47:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:52 INFO - 'installer_path': 'installer.exe', 11:47:52 INFO - 'log_level': 'info', 11:47:52 INFO - 'log_name': 'talos', 11:47:52 INFO - 'log_to_console': True, 11:47:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:47:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:47:52 INFO - 'opt_config_files': (), 11:47:52 INFO - 'pip_index': False, 11:47:52 INFO - 'sps_profile': False, 11:47:52 INFO - 'sps_profile_interval': 0, 11:47:52 INFO - 'suite': 'dromaeojs', 11:47:52 INFO - 'system_bits': '32', 11:47:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:52 INFO - 'title': 'talos-linux64-ix-066', 11:47:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:52 INFO - 'use_talos_json': True, 11:47:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:52 INFO - 'work_dir': 'build'} 11:47:52 INFO - ##### 11:47:52 INFO - ##### Running clobber step. 11:47:52 INFO - ##### 11:47:52 INFO - Running pre-action listener: _resource_record_pre_action 11:47:52 INFO - Running main action method: clobber 11:47:52 INFO - rmtree: /builds/slave/test/build 11:47:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:52 INFO - Running post-action listener: _resource_record_post_action 11:47:52 INFO - ##### 11:47:52 INFO - ##### Running read-buildbot-config step. 11:47:52 INFO - ##### 11:47:52 INFO - Running pre-action listener: _resource_record_pre_action 11:47:52 INFO - Running main action method: read_buildbot_config 11:47:52 INFO - Using buildbot properties: 11:47:52 INFO - { 11:47:52 INFO - "project": "", 11:47:52 INFO - "product": "firefox", 11:47:52 INFO - "script_repo_revision": "production", 11:47:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:47:52 INFO - "repository": "", 11:47:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:47:52 INFO - "buildid": "20160324104957", 11:47:52 INFO - "pgo_build": "False", 11:47:52 INFO - "basedir": "/builds/slave/test", 11:47:52 INFO - "buildnumber": 1572, 11:47:52 INFO - "slavename": "talos-linux64-ix-066", 11:47:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:47:52 INFO - "platform": "ubuntu64_hw", 11:47:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:47:52 INFO - "branch": "fx-team", 11:47:52 INFO - "repo_path": "integration/fx-team", 11:47:52 INFO - "revision": "5a437d55565701acfa66934ebcbefb4212c458a4", 11:47:52 INFO - "stage_platform": "linux64", 11:47:52 INFO - "builduid": "b8d190aed2474d2cadeaecad5b38da11", 11:47:52 INFO - "slavebuilddir": "test" 11:47:52 INFO - } 11:47:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:47:52 INFO - Running post-action listener: _resource_record_post_action 11:47:52 INFO - ##### 11:47:52 INFO - ##### Running download-and-extract step. 11:47:52 INFO - ##### 11:47:52 INFO - Running pre-action listener: _resource_record_pre_action 11:47:52 INFO - Running main action method: download_and_extract 11:47:52 INFO - mkdir: /builds/slave/test/build/tests 11:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:52 INFO - https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:47:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:47:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:47:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:47:54 INFO - Downloaded 1361 bytes. 11:47:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:47:54 INFO - Using the following test package requirements: 11:47:54 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:47:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:47:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:47:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'jsshell-linux-x86_64.zip'], 11:47:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:47:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:47:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:47:54 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:47:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:47:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:47:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:47:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:54 INFO - https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:02 INFO - Downloaded 22068667 bytes. 11:48:02 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'] 11:48:02 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 11:48:03 INFO - Return code: 0 11:48:03 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 11:48:03 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')]} 11:48:03 INFO - https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:05 INFO - Downloaded 22068667 bytes. 11:48:05 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'] 11:48:05 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 11:48:06 INFO - Return code: 0 11:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:06 INFO - https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:10 INFO - Downloaded 10847187 bytes. 11:48:10 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'] 11:48:10 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 11:48:10 INFO - Return code: 0 11:48: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')]} 11:48:10 INFO - https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBRGsI16QXKYDcV0lFuXow/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 11:48:19 INFO - Downloaded 54265572 bytes. 11:48:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:48:19 INFO - mkdir: /builds/slave/test/properties 11:48:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:19 INFO - Contents: 11:48:19 INFO - build_url:https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:48:20 INFO - Running post-action listener: _resource_record_post_action 11:48:20 INFO - Running post-action listener: set_extra_try_arguments 11:48:20 INFO - ##### 11:48:20 INFO - ##### Running populate-webroot step. 11:48:20 INFO - ##### 11:48:20 INFO - Running pre-action listener: _resource_record_pre_action 11:48:20 INFO - Running main action method: populate_webroot 11:48:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:20 INFO - '--tppagecycles', 11:48:20 INFO - '7'], 11:48:20 INFO - 'tests': ['tsvgm']}}, 11:48:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:48:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:48:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['damp', 'tps']}, 11:48:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['damp', 'tps']}, 11:48:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:48:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:20 INFO - 'other': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other_l64': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other_nol64': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'svgr': {'tests': ['tsvgx', 11:48:20 INFO - 'tsvgr_opacity', 11:48:20 INFO - 'tart', 11:48:20 INFO - 'tscrollx', 11:48:20 INFO - 'cart']}, 11:48:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['tsvgx', 11:48:20 INFO - 'tsvgr_opacity', 11:48:20 INFO - 'tart', 11:48:20 INFO - 'tscrollx', 11:48:20 INFO - 'cart']}, 11:48:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['tp5o']}, 11:48:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--e10s'], 11:48:20 INFO - 'tests': ['tp5o']}, 11:48:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--xperf_path', 11:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:20 INFO - 'tests': ['tp5n']}, 11:48:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--e10s', 11:48:20 INFO - '--xperf_path', 11:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:20 INFO - 'tests': ['tp5n']}}, 11:48:20 INFO - 'talos.zip': {'path': '', 11:48:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:20 INFO - Running post-action listener: _resource_record_post_action 11:48:20 INFO - ##### 11:48:20 INFO - ##### Running create-virtualenv step. 11:48:20 INFO - ##### 11:48:20 INFO - Running pre-action listener: _resource_record_pre_action 11:48:20 INFO - Running main action method: create_virtualenv 11:48:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:20 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 11:48:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:20 INFO - Using real prefix '/usr' 11:48:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:23 INFO - Installing pip.................done. 11:48:23 INFO - Return code: 0 11:48:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48: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', 'pip>=1.5'] in /builds/slave/test/build 11:48: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 pip>=1.5 11:48:23 INFO - Using env: {'DISPLAY': ':0', 11:48:23 INFO - 'HOME': '/home/cltbld', 11:48:23 INFO - 'LANG': 'en_US.UTF-8', 11:48:23 INFO - 'LANGUAGE': 'en_US:en', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MAIL': '/var/mail/cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SHLVL': '1', 11:48:23 INFO - 'TERM': 'linux', 11:48:23 INFO - 'TMOUT': '86400', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - '_': '/tools/buildbot/bin/python'} 11:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:23 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 11:48:23 INFO - Cleaning up... 11:48:23 INFO - Return code: 0 11:48:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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', '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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:48: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 psutil>=0.7.1 11:48:23 INFO - Using env: {'DISPLAY': ':0', 11:48:23 INFO - 'HOME': '/home/cltbld', 11:48:23 INFO - 'LANG': 'en_US.UTF-8', 11:48:23 INFO - 'LANGUAGE': 'en_US:en', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MAIL': '/var/mail/cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SHLVL': '1', 11:48:23 INFO - 'TERM': 'linux', 11:48:23 INFO - 'TMOUT': '86400', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - '_': '/tools/buildbot/bin/python'} 11:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:23 INFO - Downloading/unpacking psutil>=0.7.1 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:28 INFO - Installing collected packages: psutil 11:48:28 INFO - Running setup.py install for psutil 11:48:28 INFO - building 'psutil._psutil_linux' extension 11:48:28 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 11:48:28 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 11:48:28 INFO - building 'psutil._psutil_posix' extension 11:48:28 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 11:48:28 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 11:48:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:28 INFO - Successfully installed psutil 11:48:28 INFO - Cleaning up... 11:48:28 INFO - Return code: 0 11:48:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:28 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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:28 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 11:48:28 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 11:48:28 INFO - Using env: {'DISPLAY': ':0', 11:48:28 INFO - 'HOME': '/home/cltbld', 11:48:28 INFO - 'LANG': 'en_US.UTF-8', 11:48:28 INFO - 'LANGUAGE': 'en_US:en', 11:48:28 INFO - 'LOGNAME': 'cltbld', 11:48:28 INFO - 'MAIL': '/var/mail/cltbld', 11:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:28 INFO - 'MOZ_NO_REMOTE': '1', 11:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:28 INFO - 'NO_EM_RESTART': '1', 11:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:28 INFO - 'PWD': '/builds/slave/test', 11:48:28 INFO - 'SHELL': '/bin/bash', 11:48:28 INFO - 'SHLVL': '1', 11:48:28 INFO - 'TERM': 'linux', 11:48:28 INFO - 'TMOUT': '86400', 11:48:28 INFO - 'USER': 'cltbld', 11:48:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:28 INFO - '_': '/tools/buildbot/bin/python'} 11:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:48:29 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 11:48:29 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 11:48:29 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 11:48:29 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 11:48:29 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 11:48:29 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 11:48:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:48:32 INFO - Installing collected packages: mozsystemmonitor 11:48:32 INFO - Running setup.py install for mozsystemmonitor 11:48:33 INFO - Successfully installed mozsystemmonitor 11:48:33 INFO - Cleaning up... 11:48:33 INFO - Return code: 0 11:48:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:33 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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:33 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 11:48:33 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 11:48:33 INFO - Using env: {'DISPLAY': ':0', 11:48:33 INFO - 'HOME': '/home/cltbld', 11:48:33 INFO - 'LANG': 'en_US.UTF-8', 11:48:33 INFO - 'LANGUAGE': 'en_US:en', 11:48:33 INFO - 'LOGNAME': 'cltbld', 11:48:33 INFO - 'MAIL': '/var/mail/cltbld', 11:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:33 INFO - 'MOZ_NO_REMOTE': '1', 11:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:33 INFO - 'NO_EM_RESTART': '1', 11:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:33 INFO - 'PWD': '/builds/slave/test', 11:48:33 INFO - 'SHELL': '/bin/bash', 11:48:33 INFO - 'SHLVL': '1', 11:48:33 INFO - 'TERM': 'linux', 11:48:33 INFO - 'TMOUT': '86400', 11:48:33 INFO - 'USER': 'cltbld', 11:48:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:33 INFO - '_': '/tools/buildbot/bin/python'} 11:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:33 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:33 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 11:48:33 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 11:48:33 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 11:48:33 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 11:48:33 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 11:48:33 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 11:48:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:37 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 11:48:37 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 11:48:37 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 11:48:37 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 11:48:37 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 11:48:37 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 11:48:37 INFO - Downloading docopt-0.6.1.tar.gz 11:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:37 INFO - Running setup.py install for blobuploader 11:48:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:37 INFO - Running setup.py install for requests 11:48:37 INFO - Running setup.py install for docopt 11:48:38 INFO - Successfully installed blobuploader requests docopt 11:48:38 INFO - Cleaning up... 11:48:38 INFO - Return code: 0 11:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:38 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')]} 11:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 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')]} 11:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:38 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 11:48:38 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 11:48:38 INFO - Using env: {'DISPLAY': ':0', 11:48:38 INFO - 'HOME': '/home/cltbld', 11:48:38 INFO - 'LANG': 'en_US.UTF-8', 11:48:38 INFO - 'LANGUAGE': 'en_US:en', 11:48:38 INFO - 'LOGNAME': 'cltbld', 11:48:38 INFO - 'MAIL': '/var/mail/cltbld', 11:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:38 INFO - 'MOZ_NO_REMOTE': '1', 11:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:38 INFO - 'NO_EM_RESTART': '1', 11:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:38 INFO - 'PWD': '/builds/slave/test', 11:48:38 INFO - 'SHELL': '/bin/bash', 11:48:38 INFO - 'SHLVL': '1', 11:48:38 INFO - 'TERM': 'linux', 11:48:38 INFO - 'TMOUT': '86400', 11:48:38 INFO - 'USER': 'cltbld', 11:48:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:38 INFO - '_': '/tools/buildbot/bin/python'} 11:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:39 INFO - Running setup.py (path:/tmp/pip-P16Yh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:39 INFO - Running setup.py (path:/tmp/pip-YKVpnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:39 INFO - Running setup.py (path:/tmp/pip-vdiOCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:39 INFO - Running setup.py (path:/tmp/pip-l0Hc0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:39 INFO - Running setup.py (path:/tmp/pip-48gktf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:39 INFO - Running setup.py (path:/tmp/pip-yPmbUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:39 INFO - Running setup.py (path:/tmp/pip-C4VYTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:39 INFO - Running setup.py (path:/tmp/pip-jKOp0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:39 INFO - Running setup.py (path:/tmp/pip-N3SJUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:39 INFO - Running setup.py (path:/tmp/pip-Yf4Fp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:39 INFO - Running setup.py (path:/tmp/pip-w4154R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:39 INFO - Running setup.py (path:/tmp/pip-EnYXmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:39 INFO - Running setup.py (path:/tmp/pip-ynHEwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:39 INFO - Running setup.py (path:/tmp/pip-7mFewU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:40 INFO - Running setup.py (path:/tmp/pip-vzn4Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:40 INFO - Running setup.py (path:/tmp/pip-v_HRpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:40 INFO - Running setup.py (path:/tmp/pip-2rMvxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:40 INFO - Running setup.py install for manifestparser 11:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:40 INFO - Running setup.py install for mozcrash 11:48:40 INFO - Running setup.py install for mozdebug 11:48:40 INFO - Running setup.py install for mozdevice 11:48:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:40 INFO - Running setup.py install for mozfile 11:48:40 INFO - Running setup.py install for mozhttpd 11:48:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:40 INFO - Running setup.py install for mozinfo 11:48:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:40 INFO - Running setup.py install for mozInstall 11:48:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Running setup.py install for mozleak 11:48:41 INFO - Running setup.py install for mozlog 11:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Running setup.py install for moznetwork 11:48:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Running setup.py install for mozprocess 11:48:41 INFO - Running setup.py install for mozprofile 11:48:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Running setup.py install for mozrunner 11:48:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:41 INFO - Running setup.py install for mozscreenshot 11:48:41 INFO - Running setup.py install for moztest 11:48:41 INFO - Running setup.py install for mozversion 11:48:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:42 INFO - Cleaning up... 11:48:42 INFO - Return code: 0 11:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:42 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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:42 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 11:48:42 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 11:48:42 INFO - Using env: {'DISPLAY': ':0', 11:48:42 INFO - 'HOME': '/home/cltbld', 11:48:42 INFO - 'LANG': 'en_US.UTF-8', 11:48:42 INFO - 'LANGUAGE': 'en_US:en', 11:48:42 INFO - 'LOGNAME': 'cltbld', 11:48:42 INFO - 'MAIL': '/var/mail/cltbld', 11:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:42 INFO - 'MOZ_NO_REMOTE': '1', 11:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:42 INFO - 'NO_EM_RESTART': '1', 11:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:42 INFO - 'PWD': '/builds/slave/test', 11:48:42 INFO - 'SHELL': '/bin/bash', 11:48:42 INFO - 'SHLVL': '1', 11:48:42 INFO - 'TERM': 'linux', 11:48:42 INFO - 'TMOUT': '86400', 11:48:42 INFO - 'USER': 'cltbld', 11:48:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:42 INFO - '_': '/tools/buildbot/bin/python'} 11:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:42 INFO - Running setup.py (path:/tmp/pip-MGtWZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:42 INFO - Running setup.py (path:/tmp/pip-lNrVLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:42 INFO - Running setup.py (path:/tmp/pip-WpcJYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:42 INFO - Running setup.py (path:/tmp/pip-VX6DLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:42 INFO - Running setup.py (path:/tmp/pip-7q_q1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:42 INFO - Running setup.py (path:/tmp/pip-z_qmiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:42 INFO - Running setup.py (path:/tmp/pip-xdsrKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:42 INFO - Running setup.py (path:/tmp/pip-zW4THu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:42 INFO - Running setup.py (path:/tmp/pip-fFIe8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:42 INFO - Running setup.py (path:/tmp/pip-B0Wt55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:42 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)) 11:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:42 INFO - Running setup.py (path:/tmp/pip-4ztCnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:43 INFO - Running setup.py (path:/tmp/pip-KyVmkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:43 INFO - Running setup.py (path:/tmp/pip-YWK5W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:43 INFO - Running setup.py (path:/tmp/pip-RDE27a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:43 INFO - Running setup.py (path:/tmp/pip-NFFKYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:43 INFO - Running setup.py (path:/tmp/pip-uhDrRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:43 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)) 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:43 INFO - Running setup.py (path:/tmp/pip-UqrH0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:43 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)) 11:48:43 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)) 11:48:43 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)) 11:48:43 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)) 11:48:43 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)) 11:48:43 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)) 11:48:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:46 INFO - Downloading blessings-1.6.tar.gz 11:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:47 INFO - Installing collected packages: blessings 11:48:47 INFO - Running setup.py install for blessings 11:48:47 INFO - Successfully installed blessings 11:48:47 INFO - Cleaning up... 11:48:47 INFO - Return code: 0 11:48:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:47 INFO - Reading from file tmpfile_stdout 11:48:47 INFO - Current package versions: 11:48:47 INFO - argparse == 1.2.1 11:48:47 INFO - blessings == 1.6 11:48:47 INFO - blobuploader == 1.2.4 11:48:47 INFO - docopt == 0.6.1 11:48:47 INFO - manifestparser == 1.1 11:48:47 INFO - mozInstall == 1.12 11:48:47 INFO - mozcrash == 0.17 11:48:47 INFO - mozdebug == 0.1 11:48:47 INFO - mozdevice == 0.48 11:48:47 INFO - mozfile == 1.2 11:48:47 INFO - mozhttpd == 0.7 11:48:47 INFO - mozinfo == 0.9 11:48:47 INFO - mozleak == 0.1 11:48:47 INFO - mozlog == 3.1 11:48:47 INFO - moznetwork == 0.27 11:48:47 INFO - mozprocess == 0.22 11:48:47 INFO - mozprofile == 0.28 11:48:47 INFO - mozrunner == 6.11 11:48:47 INFO - mozscreenshot == 0.1 11:48:47 INFO - mozsystemmonitor == 0.0 11:48:47 INFO - moztest == 0.7 11:48:47 INFO - mozversion == 1.4 11:48:47 INFO - psutil == 3.1.1 11:48:47 INFO - requests == 1.2.3 11:48:47 INFO - wsgiref == 0.1.2 11:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 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 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:47 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 11:48:47 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 11:48:47 INFO - Using env: {'DISPLAY': ':0', 11:48:47 INFO - 'HOME': '/home/cltbld', 11:48:47 INFO - 'LANG': 'en_US.UTF-8', 11:48:47 INFO - 'LANGUAGE': 'en_US:en', 11:48:47 INFO - 'LOGNAME': 'cltbld', 11:48:47 INFO - 'MAIL': '/var/mail/cltbld', 11:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:47 INFO - 'MOZ_NO_REMOTE': '1', 11:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:47 INFO - 'NO_EM_RESTART': '1', 11:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:47 INFO - 'PWD': '/builds/slave/test', 11:48:47 INFO - 'SHELL': '/bin/bash', 11:48:47 INFO - 'SHLVL': '1', 11:48:47 INFO - 'TERM': 'linux', 11:48:47 INFO - 'TMOUT': '86400', 11:48:47 INFO - 'USER': 'cltbld', 11:48:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:47 INFO - '_': '/tools/buildbot/bin/python'} 11:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 INFO - Cleaning up... 11:48:47 INFO - Return code: 0 11:48:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:48:47 INFO - Using env: {'DISPLAY': ':0', 11:48:47 INFO - 'HOME': '/home/cltbld', 11:48:47 INFO - 'LANG': 'en_US.UTF-8', 11:48:47 INFO - 'LANGUAGE': 'en_US:en', 11:48:47 INFO - 'LOGNAME': 'cltbld', 11:48:47 INFO - 'MAIL': '/var/mail/cltbld', 11:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:47 INFO - 'MOZ_NO_REMOTE': '1', 11:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:47 INFO - 'NO_EM_RESTART': '1', 11:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:47 INFO - 'PWD': '/builds/slave/test', 11:48:47 INFO - 'SHELL': '/bin/bash', 11:48:47 INFO - 'SHLVL': '1', 11:48:47 INFO - 'TERM': 'linux', 11:48:47 INFO - 'TMOUT': '86400', 11:48:47 INFO - 'USER': 'cltbld', 11:48:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:47 INFO - '_': '/tools/buildbot/bin/python'} 11:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:47 INFO - Downloading/unpacking jsonschema 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:51 INFO - Downloading/unpacking functools32 (from jsonschema) 11:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:51 INFO - warning: no files found matching '*.txt' 11:48:51 INFO - no previously-included directories found matching 'build' 11:48:51 INFO - no previously-included directories found matching 'dist' 11:48:51 INFO - no previously-included directories found matching '.git*' 11:48:51 INFO - Installing collected packages: jsonschema, functools32 11:48:51 INFO - Running setup.py install for functools32 11:48:51 INFO - warning: no files found matching '*.txt' 11:48:51 INFO - no previously-included directories found matching 'build' 11:48:51 INFO - no previously-included directories found matching 'dist' 11:48:51 INFO - no previously-included directories found matching '.git*' 11:48:51 INFO - Successfully installed jsonschema functools32 11:48:51 INFO - Cleaning up... 11:48:51 INFO - Return code: 0 11:48:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf7566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', '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 11:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:48:51 INFO - Using env: {'DISPLAY': ':0', 11:48:51 INFO - 'HOME': '/home/cltbld', 11:48:51 INFO - 'LANG': 'en_US.UTF-8', 11:48:51 INFO - 'LANGUAGE': 'en_US:en', 11:48:51 INFO - 'LOGNAME': 'cltbld', 11:48:51 INFO - 'MAIL': '/var/mail/cltbld', 11:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:51 INFO - 'MOZ_NO_REMOTE': '1', 11:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:51 INFO - 'NO_EM_RESTART': '1', 11:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:51 INFO - 'PWD': '/builds/slave/test', 11:48:51 INFO - 'SHELL': '/bin/bash', 11:48:51 INFO - 'SHLVL': '1', 11:48:51 INFO - 'TERM': 'linux', 11:48:51 INFO - 'TMOUT': '86400', 11:48:51 INFO - 'USER': 'cltbld', 11:48:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:51 INFO - '_': '/tools/buildbot/bin/python'} 11:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:52 INFO - Downloading/unpacking flake8 11:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:48:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:48:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:56 INFO - no previously-included directories found matching 'docs/_build' 11:48:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:48:56 INFO - Running setup.py install for pep8 11:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:57 INFO - no previously-included directories found matching 'docs/_build' 11:48:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:48:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:48:57 INFO - Cleaning up... 11:48:57 INFO - Return code: 0 11:48:57 INFO - Running post-action listener: _resource_record_post_action 11:48:57 INFO - Running post-action listener: _start_resource_monitoring 11:48:57 INFO - Starting resource monitoring. 11:48:57 INFO - ##### 11:48:57 INFO - ##### Running install step. 11:48:57 INFO - ##### 11:48:57 INFO - Running pre-action listener: _resource_record_pre_action 11:48:57 INFO - Running main action method: install 11:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:57 INFO - Reading from file tmpfile_stdout 11:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:57 INFO - Reading from file tmpfile_stdout 11:48:57 INFO - Output received: 11:48:57 INFO - Usage: mozinstall [options] installer 11:48:57 INFO - Options: 11:48:57 INFO - -h, --help show this help message and exit 11:48:57 INFO - -d DEST, --destination=DEST 11:48:57 INFO - Directory to install application into. [default: 11:48:57 INFO - "/builds/slave/test"] 11:48:57 INFO - --app=APP Application being installed. [default: firefox] 11:48:57 INFO - mkdir: /builds/slave/test/build/application 11:48:57 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'] 11:48:57 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 11:49:13 INFO - Reading from file tmpfile_stdout 11:49:13 INFO - Output received: 11:49:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:49:13 INFO - Running post-action listener: _resource_record_post_action 11:49:13 INFO - ##### 11:49:13 INFO - ##### Running run-tests step. 11:49:13 INFO - ##### 11:49:13 INFO - Running pre-action listener: _resource_record_pre_action 11:49:13 INFO - Running main action method: run_tests 11:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:13 INFO - Python 2.7.3 11:49:13 INFO - Return code: 0 11:49:13 INFO - grabbing minidump binary from tooltool 11:49:13 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')]} 11:49:13 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 0x1ea4410>, '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 0x1ea5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:13 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 11:49:13 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 11:49:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:13 INFO - Return code: 0 11:49:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:49:14 INFO - Return code: 0 11:49:14 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/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:49:14 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/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 11:49:14 INFO - Using env: {'DISPLAY': ':0', 11:49:14 INFO - 'HOME': '/home/cltbld', 11:49:14 INFO - 'LANG': 'en_US.UTF-8', 11:49:14 INFO - 'LANGUAGE': 'en_US:en', 11:49:14 INFO - 'LOGNAME': 'cltbld', 11:49:14 INFO - 'MAIL': '/var/mail/cltbld', 11:49:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:14 INFO - 'MOZ_NO_REMOTE': '1', 11:49:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:14 INFO - 'NO_EM_RESTART': '1', 11:49:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:14 INFO - 'PWD': '/builds/slave/test', 11:49:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:14 INFO - 'SHELL': '/bin/bash', 11:49:14 INFO - 'SHLVL': '1', 11:49:14 INFO - 'TERM': 'linux', 11:49:14 INFO - 'TMOUT': '86400', 11:49:14 INFO - 'USER': 'cltbld', 11:49:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677', 11:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:14 INFO - '_': '/tools/buildbot/bin/python'} 11:49:14 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/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:49:14 INFO - mozversion application_buildid: 20160324104957 11:49:14 INFO - mozversion application_changeset: 5a437d55565701acfa66934ebcbefb4212c458a4 11:49:14 INFO - mozversion application_display_name: Nightly 11:49:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:14 INFO - mozversion application_name: Firefox 11:49:14 INFO - mozversion application_remotingname: firefox 11:49:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:49:14 INFO - mozversion application_vendor: Mozilla 11:49:14 INFO - mozversion application_version: 48.0a1 11:49:14 INFO - mozversion platform_buildid: 20160324104957 11:49:14 INFO - mozversion platform_changeset: 5a437d55565701acfa66934ebcbefb4212c458a4 11:49:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:49:14 INFO - mozversion platform_version: 48.0a1 11:49:14 INFO - using testdate: 1458845354 11:49:14 INFO - actual date: 1458845354 11:49:14 INFO - starting webserver on 'localhost:52338' 11:49:14 INFO - SUITE-START | Running 2 tests 11:49:14 INFO - TEST-START | dromaeo_css 11:49:14 INFO - operating with platform_type : linux_ 11:49:14 INFO - Initialising browser for dromaeo_css test... 11:49:14 INFO - TEST-INFO | started process 5808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvZWxF/profile http://localhost:52338/getInfo.html) 11:49:18 INFO - PROCESS | 5808 | __metrics Screen width/height:1600/1200 11:49:18 INFO - PROCESS | 5808 | colorDepth:24 11:49:18 INFO - PROCESS | 5808 | Browser inner width/height: 1024/697 11:49:18 INFO - PROCESS | 5808 | __metrics 11:49:19 ERROR - PROCESS | 5808 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:49:20 INFO - TEST-INFO | 5808: exit 0 11:49:20 INFO - Browser initialized. 11:49:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:20 INFO - TEST-INFO | started process 5904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvZWxF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:32 INFO - PROCESS | 5904 | RSS: Main: 154992640 11:49:32 INFO - PROCESS | 5904 | 11:50:23 INFO - PROCESS | 5904 | 1458845423849 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] 11:52:35 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52338/tests/dromaeo/cssquery-ext.html) 11:52:36 INFO - PROCESS | 5904 | RSS: Main: 240566272 11:52:36 INFO - PROCESS | 5904 | 11:55:38 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-ext.html (next: http://localhost:52338/tests/dromaeo/cssquery-jquery.html) 11:55:39 INFO - PROCESS | 5904 | RSS: Main: 237568000 11:55:39 INFO - PROCESS | 5904 | 11:58:41 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52338/tests/dromaeo/cssquery-mootools.html) 11:58:41 INFO - PROCESS | 5904 | RSS: Main: 228941824 11:58:41 INFO - PROCESS | 5904 | 12:01:43 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52338/tests/dromaeo/cssquery-prototype.html) 12:01:44 INFO - PROCESS | 5904 | RSS: Main: 215920640 12:01:44 INFO - PROCESS | 5904 | 12:04:47 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52338/tests/dromaeo/cssquery-yui.html) 12:04:47 INFO - PROCESS | 5904 | RSS: Main: 198512640 12:04:47 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | Cycle 1(1): loaded http://localhost:52338/tests/dromaeo/cssquery-yui.html (next: http://localhost:52338/tests/dromaeo/cssquery-dojo.html) 12:07:50 INFO - PROCESS | 5904 | RSS: Main: 289476608 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | __start_tp_report 12:07:50 INFO - PROCESS | 5904 | _x_x_mozilla_page_load 12:07:50 INFO - PROCESS | 5904 | _x_x_mozilla_page_load_details 12:07:50 INFO - PROCESS | 5904 | |i|pagename|runs| 12:07:50 INFO - PROCESS | 5904 | |0;dojo.html;2572.344052266672;2661.4544018476226;2667.973320266799;2681.7452342027514;2698.8515631640257;4672.742999135055;4710.387649605551;4711.858644240674;4718.787654555545;4755.6908800928;4704.717716936986;4730.0776348612035;4742.264948932912;4832.154372984731;4832.516748325165;4300.806463709125;4313.2451820931365;4360.127974405116;4385.035292235703;4431.202383570956;4348.695591308609;4378.058717375764;4396.36252743352;4399.560043995591;4430.579094985971;4261.808218630169;4294.699371044013;4303.91392172158;4340.9798697306105;4350.064736081726;4338.739675619473;4360.738355698668;4362.934555981663;4407.911841763179;4413.602775750166;4343.1965086458795;4345.913081738379;4351.129774045204;4358.237308471036;4378.978105109486;4476.7090139140855;4592.265237561974;4643.791029403685;4694.577488026094;4731.858044258678;5033.320501732256;5062.620303477217;5068.873278168038;5111.361079865017;5122.92315615266;5006.4743201964;5066.493350664941;5086.669366491166;5087.49125087492;5093;4707.670463067587;4740.644451666139;4756.096341695067;4785.114753770494;4788.640851936084;5178.456262092502;5219.660722053054;5221.556167725786;5228.9477105229225;5277.8416647500635;4904.485029071968;4963.6277279204205;5013.1227035268685;5015;5051.797928082836;5023.82416615424;5042.420121686053;5044.596432285409;5066.620003499752;5090.338256026693;4981.2030075187795;4984.526469985346;4989.101961646866;4991.700497970133;5040.974795126074;4881.267809828554;4943.8516844494725;4963.925541116886;4993.70037797726;5011.974940125276;4268.338407546835;4279.3153095505195;4280.122574872144;4302.397664326997;4312.978435107867;3704.49989251453;3735;3740.17716102457;3764.9247015059545;3782.8486860525823;4283.121959998255;4312.719673221231;4349.586789255016;4368.104538569585;4396.934045989313;5128.3076784633595;5133.307003554547;5141.3830340358645;5147.6911385317;5156.097682905552;4388;4394.384786129945;4395.055063161436;4413.867583972486;4448.822047118144;4470.463544374696;4538.863834084983;4588.816447342136;4600.171969045537;4615.23848564983;4761.40482439695;4775.570198682135;4791.0178413425165;4794.448638406628;4839.685420447659;5058.089543882136;5086;5104.05574968632;5106.642535022513;5153.639245252946;4649.558291962258;4763.333133361401;4811.398575178103;4832.855014349575;4834.299026641047;4999.200127979506;5019.548240658358;5025.673331233458;5036.471170527042;5087.008033433445;4900.995295964248;5089.923651145162;5115.335006449138;5123.641345105956;5126.957971848964;4915.238138088459;4927.457979622167;4953.554180123806;4991;5000.6249531284575;4939.728314942713;4968.801247950041;4969.82605608802;4975.4278258000795;5014.623903207201;4795.496472870298;4820.517948205152;4901.313816065683;4902.828401005948;4968;4921.557059864629;4947.406311242674;4950.801967921243;4976.651634385558;4995.825146119869;4823.3729615149805;4824.517548245148;4829.468758436499;4830.879228019187;4879.4876537963 12:07:50 INFO - PROCESS | 5904 | |1;ext.html;495.23733450486253;521.4055976187146;535.8928214357124;538.8060298292617;541.226046753143;27498.31254218643;27919.44161116779;33863.66136338639;34292;34372.828135859345;37824.43263351045;38406.423903641466;38406.8079659602;38460.42309365362;38478.807605962;7693.230676932318;7854;7884.921150788505;7885.723999660013;7886.881696774553;7721.884171737428;7834.72578459754;7845.254700803414;7846.960765196166;7847.725329613465;7984.3213326867;8073.515589064675;8075.636596353178;8078.232567906069;8078.515289082674;7973.32226760726;8008.719694810712;8048.557329346883;8054.798630034237;8063.354931605458;7936.365090792723;8051.677932882678;8079.676812927476;8087.47431416956;8090.069641991128;38872.22255554873;39246.607533924864;39352.21295574101;39367.60632393668;39397.212055758726;3179.8887038953526;3397.8640854365794;3611.2416392557593;3681.576618688858;3956.268090403256;29850.85074574635;29888;30480;30509.694903050906;30654.386912261853;3403.9659603403898;3412.3516531859113;3459.844307006191;3475.8609655613745;3523.312953973976;257098;259365;259533;259961.9999999981;260072;41534;57788;58979;59007.40992590019;59132;39768.80115599462;39923.60076399199;40064.799676001436;40086.79956600257;40160.39759403611;14651.853481465261;14703.117812931258;14898.925505372405;14911.478098266509;14931.776023359658;11660.53357865676;11710.297382157098;11714.531418743154;11733.882661173278;11753.353565553976;14731.337089830984;14751.631209219855;14789.778153327708;14900.019996000843;15037.398504059935;5625.184348269478;5752;5867.911981320283;5867.970660146757;5885.440883116097;913.488446469979;920.6593560382702;967.1295833749682;989.317371013998;1011.9038691324313;26475.735242647712;27283;27770.166894992777;27945.580816287773;28042.579361309596;876.7501262140387;998.4159266828841;1003.1673710820002;1087.0977089016255;1093.781243751253;12921.483140674267;13090.14914030585;13203.73592528144;13235.801462978063;13261.204327740366;301941;304155;304995;305665.0184734322;305669;44508.55491445109;44962;44967.32549011702;45080.77459612681;45100.999999999345;1044.8902865199045;1124.8425220469142;1199.280431740966;1218.945147468366;1223.4066477758458;25033.74966250387;27019.86490067537;27071;27355;27665.170044898685;38135.618643813206;38543.22913541769;38646.806765965994;38648.613513864504;38668.2266354677;209798;215126;215170;215344;234202;30317;30816.84591577028;31099.84450077735;31632.209194770316;31633.5254971171;35369;36181.27637447289;36397.45403818892;36460.45309320309;36688.44967325439;29537.852310738308;30379.392412152076;30439.239019024702;30494;30683.693163068976;30544.236394090327;31245.843770781;31736;33205.33589328152;33260;32515.674843251265;33024.1743956403;33119.172020699676;33299.83350083234;33392.49911251284;29516.852415737783;30120.849395753758;30168.189908605553;30418.239544010692;30500.847495763268;23726.525469490858;23912;23960.15734673335;24018.15936442216;24331.39171520726 12:07:50 INFO - PROCESS | 5904 | |2;jquery.html;351.3815684395463;352.654622614725;360.2039492721087;363.5782492308922;368.53932584269666;15376.769348459782;15843.920780396096;16090.1954902255;16431.507054788344;16462.176891155425;15601.14193719345;16093;16248.51254462368;16249.593760156002;16284;5070;5200.063988482072;5234.450382709818;6415.935840641604;6792.083068785725;6699.497537684669;6722.361375669304;6725.024871393645;6764.7970560883;6767.830804229909;6502.70737816797;6728;6757.932420675804;6760.628165450898;6772;6652.900206496906;6717.529772915874;6736.023276624911;6745.8650826983185;6758.560693554928;6125.632462052291;6381.329960354143;6387.297397286295;6388.872222555569;6389.808305750835;20798.16807327705;20802.687959680617;22621.547569048693;22640.77359226403;22682.432939176488;2041.612093702192;2198.560287942402;2225.2100504320897;2234.218023691711;2277.487565297811;13200.603981880558;13830;14187.219702916336;14507.637309067357;14709.852901470955;1941.1167918597005;1973.6546104431668;1973.6940774180025;1996;2047.9590408191902;47894;48153.51846481526;49926.07688004471;50894;59520.70239648774;14806.703865922622;15112.471063512725;15216.695666086838;15340.156291403857;15384.923075384775;21353.572928541344;23249.418764530685;24254.272371828873;24469.265922022012;24516.754832451803;8697.869531957025;8750.387472876837;8814.691485797966;8862.246709029676;9033.683821066232;7496.175420703718;7589.316961473383;7631.961840190764;7660.655270512729;7740.380769538423;7396.519226250277;7547.849043019109;7558.924410755932;7622.390208783284;7741.683913734679;2985.5220167261123;3051.925679218224;3063.973568854459;3117.719405253538;3136.48248039071;832.4464231286248;861.237804542984;881.1716986033236;961.0053594529628;973.4013581647235;16170.919145404197;16412.1793910304;16529;16690.664746820225;16888.49334519942;856.8157846063002;873.2708188662411;894.9731508054768;896.8027034052498;905.8550631898864;9374.95312523433;9393.718188454357;9521.333506654606;9544.95227523858;9680.27397945143;402656;411455;414330;418277;419770;66708.6664566674;68731.40857392826;68995;69361.3063869365;70212.2978770216;948.6869333120054;958.2669258017622;974.3958745577787;988.6687959533493;1003.7139415266614;14369.56891293263;14711.852881471048;14828.406863725762;14860.925695371454;15164.772528411862;23805.880970595037;31209;32198.678013220506;32440;32845;40189.79905100456;43035.569644303156;43138.78430607827;43366.132677345646;44297;7289.161746399232;7475.289847464483;7654.770356889302;7697.807554811175;7708.344790692854;8808.647654093764;11550.191486595857;11655.242409243372;11680.948714615726;11845.170838041598;10156.17188906004;10292.536835842555;10327.32872363294;10356.119729823049;10371.688849334532;10044.899551004397;10100.949495252476;10133.290669653054;10241;10429.26995110335;10081.344712593658;10284.897151028394;10388.636397726043;10399;10417.687469375627;7228.96385518069;7229.349358557755;7344.491631276543;7494.437917156344;7499.6875546778;9030.729078127666;9764.951175244078;10007.149392301735;10043.146332561813;10219.437930913573 12:07:50 INFO - PROCESS | 5904 | |3;mootools.html;1320.775468170411;1431.148466662336;1448.398914450503;1590.9124998125099;1802.414215380002;7409.407247420207;7671.232876712326;7677.692892284302;7679.500832445887;7679.692812287516;7507.662155203016;7689.346405555534;7703.1526532081425;7707.383409327254;7709.768706938787;1979.3171355882198;2019.7475315585552;2022.0698478699817;2267.716535433075;2304.28567144185;2230.966535501969;2304.804091652203;2305.3429772514837;2306.2043594959714;2307.8384513084093;2171.6308227601266;2215.2025270902463;2242.585121752481;2248.3592176229777;2258.3563684349965;2229.4537838229576;2236.6980457638256;2238.46276893546;2238.787315205053;2240.809531189851;2184.7050648162453;2211.955760884773;2220.911163553456;2222.377734234417;2232.2745107839855;7811.882821757678;7840.333571646417;7846.058472983222;7847.882281765778;7858.724944626968;4632.8146874125;4711.882202944919;4716.811327546894;4754.548317909793;4756.66703330767;3003.7840639086376;3121.7658675599196;3124.281415274477;3141.5601815745813;3168.7940283881476;974.3325821812082;1014.7818219082933;1022.6318525330875;1047.6176195688595;1048.3343077145992;10610;10812.78374432507;10815.78368432627;10817;10820.621278255223;4264.0832221072;4267.1892340455215;4371.803268852909;4374.256376416017;4377.737335759864;9276.11876871696;9288.164065234027;9303.674371396968;9317.72046838596;9361.344705870524;4736.1474934511425;4738.810447582127;4760.047990401933;4764.809407623726;4771.928421073687;3729.216864458494;4105.85629502966;4223.831046758095;4297.871063868089;4307.741535507879;3598.7660802047785;3619.1856832212543;3671.247394284219;3673.3020726061964;3697.0757310672334;1211.7818792617238;1215.750771091924;1224.3755684600917;1229.3791635224154;1247.52594014274;1201.897838683704;1202.7654607351658;1222.896053835416;1230.2126638951079;1258.24505296823;7155.785326440215;7172.13934327884;7198.964005180045;7239.167495737952;7421.962890185622;1022.616518805448;1040.7450174707244;1051.3271506236015;1057.8677665291839;1061.623123791043;5657.886842263131;5674.801381951612;5710.885782284414;5727.828165155052;5734.082546792577;8839.983401908734;9363.531823408803;9384;9421.90578094224;9514.571844266886;9227.53862306882;9250.537473126316;9259.02780208082;9457.054294570487;9542;6969.372756451944;7131.536450130725;7165.7850264492145;7199.89200161998;7336.7065317386705;6972.860542789014;6997.300269972962;7013.2986701329455;7018.613976231356;7045.401140902875;8285.917140828515;8468.237858592756;8492.787680308042;8706.434081784664;8718.738437846874;8650;8777.473351598925;8782.736517904474;8962.32782541299;8978.416402933788;6000.129981152621;6551.475881929529;6711.261761206166;6819.386255237053;6953.478489113438;7261.818454538678;7270.6728197230195;7272.854542909218;7301.050863387938;7302.269773022867;6499.155109835691;6673.032410300382;6675;6761.256261811099;6840.384365407137;6483.935160648522;6675.566088204251;6703.463722902254;6752.392284694204;6825.419839313714;6993.895091573732;7019.157701075904;7081.433485321265;7086.362227399559;7092.716291348494;6426.4216220540375;6480.222373315232;6484.027395890655;6503.73985040612;6558.967205163944;6665.500087493554;6727.596344219362;6728.125343705287;6728.158980127484;6732.259451460433 12:07:50 INFO - PROCESS | 5904 | |4;prototype.html;319.0460523036122;321.5642804000579;322.0419252723148;322.6338106249406;324.24127541552764;5301.284326615906;5338.572914166863;5351.277577527033;5398.514133727964;5424.972875135629;5319.627626066177;5335.5198032177095;5337.1994200869885;5337.866553336168;5349.732513374325;3931.7640941543455;4018.5981401859726;4141.979290103545;4143.212789569972;4174.206900688874;4180.581941805825;4181.121964387482;4182.2890108681595;4182.686298527623;4189.748615083105;4133.1940271647045;4133.441985331987;4133.689973252003;4136.5242997055275;4141.440905477767;3944.15200731844;4017.738846974937;4131.194417088669;4145.108801607654;4165;3664.450332450127;3669.504616876714;3678.5769636491877;3678.8528458861615;3686.6681998619983;5120.206368012927;5128.538431541179;5140.177571588565;5148.304978827885;5153.458886816905;4807;4815.5906747926465;4818.084563932876;4819.662623616348;4830.806767729287;5627.127795191752;5631.267935168402;5635.436456354373;5639.351474580394;5642.605017648766;4034.4755181826467;4039.858604948842;4041.2523683118716;4044.090079732066;4046.5953404659595;5729.656220626775;5895.911561326584;5902.61632993854;5910.995130827727;5919.260092488439;4131.483564554431;4147.917041659211;4149.398337241083;4152.6055024772595;4155.563665815046;4198.748075115503;4211.936820947688;4212.662986961036;4214.831406743696;4218.78906054696;4750.429948406213;4777.689450185727;4780.426348838092;4782.282657601388;4783.976080119647;5629.43705629442;5636.50632582366;5637.859053523613;5638.464345887216;5644.491995720405;1465.4065103633045;1492.3359105198083;1493.0668332292316;1494.783256427812;1497.8352381238055;887.245841035115;914.2274777812737;948.4735971535864;956.4309236004566;1011.2415688233824;4800.087983283165;4907.2393778964315;4914.0171965606305;4918.213085906309;4920.483349248278;5796.536277097822;5922.2597175353085;5959.910601340984;5963.7912673056235;5979.850503737442;4956.876078098005;4957.826476073392;4960.255961605716;4961.08219979305;4967.453580106186;3122.4847900096684;3159.605049368829;3164.3196712706417;3168.413843438971;3168.7940283881476;5503.367112782002;5505.449455054462;5508.807191748349;5516.310461192351;5518.862028449241;5869.178315035899;6041.72812223451;6051.909221361683;6052.697365131726;6056.848578785565;5466.9179962300595;5480.369757477862;5481.451854814487;5490.450954904478;5496.917546236729;5870.5010074144175;5874;5875.294964604275;5877.471027607536;5882.941170588239;5741.339745929272;5741.856453588526;5744.396838332083;5749.798757043483;5750.166225897138;5485.314335708036;5498.615096943336;5499.340079190522;5502.669839809624;5507.091329930677;3919.549251836075;4023.557408684984;4027.7180597357906;4032.4556184915837;4042.0703238254778;5842.328132264844;5866.618669786621;5868.735906884286;5871.970640146772;5882.911756323573;5647.774089036557;5654.180143879033;5658.490735833795;5659.603827732019;5660.886782264414;5590.468905453975;5600.159976003632;5603.35561410443;5618.52242559387;5647.378788333198;5556.777728890799;5574.832755017356;5579.442055794388;5584.636998595079;5598.10430331145;5489.725513724377;5657.038303488334;5657.236273103078;5665.12190610456;5667.574931880043;5454.727263636882;5553.639358357228;5573.832785016456;5577.944220557904;5578.107502799533 12:07:50 INFO - PROCESS | 5904 | |5;yui.html;686.5228666077077;725.2312548698384;772.4592785050464;778.2956424435883;792.3225642076025;11923.880761192386;12017.339046352447;12112.333821639806;12213.755724885508;12268.877311226885;11223.887761122387;11290.943545282262;11346.773064538704;11400.828987565194;11517.539298428073;659.9043138744879;815.4169768615468;817.9059408168048;836.1137194573771;840.1010918317403;830.1822704635929;833.6373677450298;833.9416240863142;836.1053672570353;836.6862426590029;861.9741407757746;866.4498043742237;867.3104881619128;867.5228624256665;867.7830542364409;688.4939569416475;840.1220724343045;861.1775754154767;862.7929296968745;862.8835107260534;629.3989240275525;629.8992161254223;630.0612087988909;630.9463695585881;630.9872654389684;11622.360770157638;11656;11666.125040621902;11703;11751.764964700744;11925.821112683318;12226.266424014588;12296.692582685415;12482.313472758995;12800.359982000862;10046.185920775672;10210.9489452553;10215.02957219063;10232.539535720836;10360.481975901175;3361.3277344531193;3399.9150021249666;3405.080628230364;3444.913877153066;3455.0498612881406;42570;42650.36024459604;42782;42810;42841.35737963933;9917.404955702681;10056.849147262797;10066.496675166212;10075.496225188712;10609.416482093558;15737;15815;15816.209189540477;15818.209089545477;15833.52499425019;6685.431738302299;6710.254816656308;6746.628935408501;6808.114945057111;6914.9308506914285;3794.222184452236;3827.2919509890758;3867.8646247381207;3884.2814079395403;3893.4354518594646;2806.396624725653;2903.332233586287;2908.34562223498;2918.5330347144354;2919.9562006569918;484.15273271774396;515.1191462598923;520.7005971566289;529.068838843638;538.5072658517491;523.8635182040133;555.1506195520859;590.630855715178;610.4505944649851;637.4995628431659;8201.630926608317;8231.588420578948;8267.503949763033;8283.917160828314;8485.321174306164;566.7166416791604;579.2209478251744;627.7143899525705;654.3783405764543;663.7278715726626;3345.9665403346144;3826.521684789401;3885.9160478558097;3935.4293627424436;3976;52377.7381113092;53156.20265696017;53170.73414632979;53239.46760532423;53322.20016699753;45944.54055459469;46673.29990050152;46971.76514117407;47393.28910066352;47839;41579.58420415818;41617.791911040855;41995;42154.99999999939;42487.36268955968;8664.870026949475;8857.468551886908;8876.245519130945;8912.465252084896;8921.973972993188;30550.847245763627;31028.98311609738;31624.683753162175;31777.364452711277;31881.521777172897;35864;39172.80413597914;40300;40533.39199911945;41896.581034189265;9613.567389467351;9707.563159657973;10276.332038417479;10669.41318227505;10855.620053298097;11601.709957251136;11622.88377116218;11676.591319303783;11767;12292.877071229532;11044.017241293286;11289.266197697452;11412.201145919706;11651.941740291244;11925.284482931052;11244.437778110898;11391.658250252174;11708.765824683629;11729.941350293195;11969.10231732641;10793.190510711886;11017.724556886142;11238.325700458;11509.13681473876;11535.36555489456;9422.811543769223;9651.131398173917;9693.6122555097;9857.11285984265;10037.046480584333;9564.4739539326;9592.712218633453;9635.807283854423;9652.806943861224;9654.75863103428 12:07:50 INFO - PROCESS | 5904 | __end_tp_report 12:07:50 INFO - PROCESS | 5904 | __start_cc_report 12:07:50 INFO - PROCESS | 5904 | _x_x_mozilla_cycle_collect,845 12:07:50 INFO - PROCESS | 5904 | __end_cc_report 12:07:50 INFO - PROCESS | 5904 | __startTimestamp1458846470738__endTimestamp 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | ------- Summary: start ------- 12:07:50 INFO - PROCESS | 5904 | Number of tests: 6 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#0] dojo.html Cycles:165 Average:4683.54 Median:4823.37 stddev:491.84 (10.2%) stddev-sans-first:464.63 12:07:50 INFO - PROCESS | 5904 | Values: 2572.3 2661.5 2668.0 2681.7 2698.9 4672.7 4710.4 4711.9 4718.8 4755.7 4704.7 4730.1 4742.3 4832.2 4832.5 4300.8 4313.2 4360.1 4385.0 4431.2 4348.7 4378.1 4396.4 4399.6 4430.6 4261.8 4294.7 4303.9 4341.0 4350.1 4338.7 4360.7 4362.9 4407.9 4413.6 4343.2 4345.9 4351.1 4358.2 4379.0 4476.7 4592.3 4643.8 4694.6 4731.9 5033.3 5062.6 5068.9 5111.4 5122.9 5006.5 5066.5 5086.7 5087.5 5093.0 4707.7 4740.6 4756.1 4785.1 4788.6 5178.5 5219.7 5221.6 5228.9 5277.8 4904.5 4963.6 5013.1 5015.0 5051.8 5023.8 5042.4 5044.6 5066.6 5090.3 4981.2 4984.5 4989.1 4991.7 5041.0 4881.3 4943.9 4963.9 4993.7 5012.0 4268.3 4279.3 4280.1 4302.4 4313.0 3704.5 3735.0 3740.2 3764.9 3782.8 4283.1 4312.7 4349.6 4368.1 4396.9 5128.3 5133.3 5141.4 5147.7 5156.1 4388.0 4394.4 4395.1 4413.9 4448.8 4470.5 4538.9 4588.8 4600.2 4615.2 4761.4 4775.6 4791.0 4794.4 4839.7 5058.1 5086.0 5104.1 5106.6 5153.6 4649.6 4763.3 4811.4 4832.9 4834.3 4999.2 5019.5 5025.7 5036.5 5087.0 4901.0 5089.9 5115.3 5123.6 5127.0 4915.2 4927.5 4953.6 4991.0 5000.6 4939.7 4968.8 4969.8 4975.4 5014.6 4795.5 4820.5 4901.3 4902.8 4968.0 4921.6 4947.4 4950.8 4976.7 4995.8 4823.4 4824.5 4829.5 4830.9 4879.5 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#1] ext.html Cycles:180 Average:41159.65 Median:33346.17 stddev:68712.18 (206.1%) stddev-sans-first:68837.10 12:07:50 INFO - PROCESS | 5904 | Values: 495.2 521.4 535.9 538.8 541.2 27498.3 27919.4 33863.7 34292.0 34372.8 37824.4 38406.4 38406.8 38460.4 38478.8 7693.2 7854.0 7884.9 7885.7 7886.9 7721.9 7834.7 7845.3 7847.0 7847.7 7984.3 8073.5 8075.6 8078.2 8078.5 7973.3 8008.7 8048.6 8054.8 8063.4 7936.4 8051.7 8079.7 8087.5 8090.1 38872.2 39246.6 39352.2 39367.6 39397.2 3179.9 3397.9 3611.2 3681.6 3956.3 29850.9 29888.0 30480.0 30509.7 30654.4 3404.0 3412.4 3459.8 3475.9 3523.3 257098.0 259365.0 259533.0 259962.0 260072.0 41534.0 57788.0 58979.0 59007.4 59132.0 39768.8 39923.6 40064.8 40086.8 40160.4 14651.9 14703.1 14898.9 14911.5 14931.8 11660.5 11710.3 11714.5 11733.9 11753.4 14731.3 14751.6 14789.8 14900.0 15037.4 5625.2 5752.0 5867.9 5868.0 5885.4 913.5 920.7 967.1 989.3 1011.9 26475.7 27283.0 27770.2 27945.6 28042.6 876.8 998.4 1003.2 1087.1 1093.8 12921.5 13090.1 13203.7 13235.8 13261.2 301941.0 304155.0 304995.0 305665.0 305669.0 44508.6 44962.0 44967.3 45080.8 45101.0 1044.9 1124.8 1199.3 1218.9 1223.4 25033.7 27019.9 27071.0 27355.0 27665.2 38135.6 38543.2 38646.8 38648.6 38668.2 209798.0 215126.0 215170.0 215344.0 234202.0 30317.0 30816.8 31099.8 31632.2 31633.5 35369.0 36181.3 36397.5 36460.5 36688.4 29537.9 30379.4 30439.2 30494.0 30683.7 30544.2 31245.8 31736.0 33205.3 33260.0 32515.7 33024.2 33119.2 33299.8 33392.5 29516.9 30120.8 30168.2 30418.2 30500.8 23726.5 23912.0 23960.2 24018.2 24331.4 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#2] jquery.html Cycles:180 Average:24657.70 Median:412892.50 stddev:67426.92 (16.3%) stddev-sans-first:67591.37 12:07:50 INFO - PROCESS | 5904 | Values: 351.4 352.7 360.2 363.6 368.5 15376.8 15843.9 16090.2 16431.5 16462.2 15601.1 16093.0 16248.5 16249.6 16284.0 5070.0 5200.1 5234.5 6415.9 6792.1 6699.5 6722.4 6725.0 6764.8 6767.8 6502.7 6728.0 6757.9 6760.6 6772.0 6652.9 6717.5 6736.0 6745.9 6758.6 6125.6 6381.3 6387.3 6388.9 6389.8 20798.2 20802.7 22621.5 22640.8 22682.4 2041.6 2198.6 2225.2 2234.2 2277.5 13200.6 13830.0 14187.2 14507.6 14709.9 1941.1 1973.7 1973.7 1996.0 2048.0 47894.0 48153.5 49926.1 50894.0 59520.7 14806.7 15112.5 15216.7 15340.2 15384.9 21353.6 23249.4 24254.3 24469.3 24516.8 8697.9 8750.4 8814.7 8862.2 9033.7 7496.2 7589.3 7632.0 7660.7 7740.4 7396.5 7547.8 7558.9 7622.4 7741.7 2985.5 3051.9 3064.0 3117.7 3136.5 832.4 861.2 881.2 961.0 973.4 16170.9 16412.2 16529.0 16690.7 16888.5 856.8 873.3 895.0 896.8 905.9 9375.0 9393.7 9521.3 9545.0 9680.3 402656.0 411455.0 414330.0 418277.0 419770.0 66708.7 68731.4 68995.0 69361.3 70212.3 948.7 958.3 974.4 988.7 1003.7 14369.6 14711.9 14828.4 14860.9 15164.8 23805.9 31209.0 32198.7 32440.0 32845.0 40189.8 43035.6 43138.8 43366.1 44297.0 7289.2 7475.3 7654.8 7697.8 7708.3 8808.6 11550.2 11655.2 11680.9 11845.2 10156.2 10292.5 10327.3 10356.1 10371.7 10044.9 10100.9 10133.3 10241.0 10429.3 10081.3 10284.9 10388.6 10399.0 10417.7 7229.0 7229.3 7344.5 7494.4 7499.7 9030.7 9765.0 10007.1 10043.1 10219.4 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#3] mootools.html Cycles:180 Average:5435.77 Median:6453.32 stddev:2830.20 (43.9%) stddev-sans-first:2821.23 12:07:50 INFO - PROCESS | 5904 | Values: 1320.8 1431.1 1448.4 1590.9 1802.4 7409.4 7671.2 7677.7 7679.5 7679.7 7507.7 7689.3 7703.2 7707.4 7709.8 1979.3 2019.7 2022.1 2267.7 2304.3 2231.0 2304.8 2305.3 2306.2 2307.8 2171.6 2215.2 2242.6 2248.4 2258.4 2229.5 2236.7 2238.5 2238.8 2240.8 2184.7 2212.0 2220.9 2222.4 2232.3 7811.9 7840.3 7846.1 7847.9 7858.7 4632.8 4711.9 4716.8 4754.5 4756.7 3003.8 3121.8 3124.3 3141.6 3168.8 974.3 1014.8 1022.6 1047.6 1048.3 10610.0 10812.8 10815.8 10817.0 10820.6 4264.1 4267.2 4371.8 4374.3 4377.7 9276.1 9288.2 9303.7 9317.7 9361.3 4736.1 4738.8 4760.0 4764.8 4771.9 3729.2 4105.9 4223.8 4297.9 4307.7 3598.8 3619.2 3671.2 3673.3 3697.1 1211.8 1215.8 1224.4 1229.4 1247.5 1201.9 1202.8 1222.9 1230.2 1258.2 7155.8 7172.1 7199.0 7239.2 7422.0 1022.6 1040.7 1051.3 1057.9 1061.6 5657.9 5674.8 5710.9 5727.8 5734.1 8840.0 9363.5 9384.0 9421.9 9514.6 9227.5 9250.5 9259.0 9457.1 9542.0 6969.4 7131.5 7165.8 7199.9 7336.7 6972.9 6997.3 7013.3 7018.6 7045.4 8285.9 8468.2 8492.8 8706.4 8718.7 8650.0 8777.5 8782.7 8962.3 8978.4 6000.1 6551.5 6711.3 6819.4 6953.5 7261.8 7270.7 7272.9 7301.1 7302.3 6499.2 6673.0 6675.0 6761.3 6840.4 6483.9 6675.6 6703.5 6752.4 6825.4 6993.9 7019.2 7081.4 7086.4 7092.7 6426.4 6480.2 6484.0 6503.7 6559.0 6665.5 6727.6 6728.1 6728.2 6732.3 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#4] prototype.html Cycles:180 Average:4690.15 Median:5338.22 stddev:1370.36 (25.7%) stddev-sans-first:1334.35 12:07:50 INFO - PROCESS | 5904 | Values: 319.0 321.6 322.0 322.6 324.2 5301.3 5338.6 5351.3 5398.5 5425.0 5319.6 5335.5 5337.2 5337.9 5349.7 3931.8 4018.6 4142.0 4143.2 4174.2 4180.6 4181.1 4182.3 4182.7 4189.7 4133.2 4133.4 4133.7 4136.5 4141.4 3944.2 4017.7 4131.2 4145.1 4165.0 3664.5 3669.5 3678.6 3678.9 3686.7 5120.2 5128.5 5140.2 5148.3 5153.5 4807.0 4815.6 4818.1 4819.7 4830.8 5627.1 5631.3 5635.4 5639.4 5642.6 4034.5 4039.9 4041.3 4044.1 4046.6 5729.7 5895.9 5902.6 5911.0 5919.3 4131.5 4147.9 4149.4 4152.6 4155.6 4198.7 4211.9 4212.7 4214.8 4218.8 4750.4 4777.7 4780.4 4782.3 4784.0 5629.4 5636.5 5637.9 5638.5 5644.5 1465.4 1492.3 1493.1 1494.8 1497.8 887.2 914.2 948.5 956.4 1011.2 4800.1 4907.2 4914.0 4918.2 4920.5 5796.5 5922.3 5959.9 5963.8 5979.9 4956.9 4957.8 4960.3 4961.1 4967.5 3122.5 3159.6 3164.3 3168.4 3168.8 5503.4 5505.4 5508.8 5516.3 5518.9 5869.2 6041.7 6051.9 6052.7 6056.8 5466.9 5480.4 5481.5 5490.5 5496.9 5870.5 5874.0 5875.3 5877.5 5882.9 5741.3 5741.9 5744.4 5749.8 5750.2 5485.3 5498.6 5499.3 5502.7 5507.1 3919.5 4023.6 4027.7 4032.5 4042.1 5842.3 5866.6 5868.7 5872.0 5882.9 5647.8 5654.2 5658.5 5659.6 5660.9 5590.5 5600.2 5603.4 5618.5 5647.4 5556.8 5574.8 5579.4 5584.6 5598.1 5489.7 5657.0 5657.2 5665.1 5667.6 5454.7 5553.6 5573.8 5577.9 5578.1 12:07:50 INFO - PROCESS | 5904 | 12:07:50 INFO - PROCESS | 5904 | [#5] yui.html Cycles:180 Average:12756.60 Median:42075.00 stddev:14372.33 (34.2%) stddev-sans-first:14384.06 12:07:50 INFO - PROCESS | 5904 | Values: 686.5 725.2 772.5 778.3 792.3 11923.9 12017.3 12112.3 12213.8 12268.9 11223.9 11290.9 11346.8 11400.8 11517.5 659.9 815.4 817.9 836.1 840.1 830.2 833.6 833.9 836.1 836.7 862.0 866.4 867.3 867.5 867.8 688.5 840.1 861.2 862.8 862.9 629.4 629.9 630.1 630.9 631.0 11622.4 11656.0 11666.1 11703.0 11751.8 11925.8 12226.3 12296.7 12482.3 12800.4 10046.2 10210.9 10215.0 10232.5 10360.5 3361.3 3399.9 3405.1 3444.9 3455.0 42570.0 42650.4 42782.0 42810.0 42841.4 9917.4 10056.8 10066.5 10075.5 10609.4 15737.0 15815.0 15816.2 15818.2 15833.5 6685.4 6710.3 6746.6 6808.1 6914.9 3794.2 3827.3 3867.9 3884.3 3893.4 2806.4 2903.3 2908.3 2918.5 2920.0 484.2 515.1 520.7 529.1 538.5 523.9 555.2 590.6 610.5 637.5 8201.6 8231.6 8267.5 8283.9 8485.3 566.7 579.2 627.7 654.4 663.7 3346.0 3826.5 3885.9 3935.4 3976.0 52377.7 53156.2 53170.7 53239.5 53322.2 45944.5 46673.3 46971.8 47393.3 47839.0 41579.6 41617.8 41995.0 42155.0 42487.4 8664.9 8857.5 8876.2 8912.5 8922.0 30550.8 31029.0 31624.7 31777.4 31881.5 35864.0 39172.8 40300.0 40533.4 41896.6 9613.6 9707.6 10276.3 10669.4 10855.6 11601.7 11622.9 11676.6 11767.0 12292.9 11044.0 11289.3 11412.2 11651.9 11925.3 11244.4 11391.7 11708.8 11729.9 11969.1 10793.2 11017.7 11238.3 11509.1 11535.4 9422.8 9651.1 9693.6 9857.1 10037.0 9564.5 9592.7 9635.8 9652.8 9654.8 12:07:50 INFO - PROCESS | 5904 | -------- Summary: end -------- 12:07:50 INFO - PROCESS | 5904 | 12:07:51 INFO - TEST-INFO | 5904: exit 0 12:07:51 INFO - TEST-OK | dromaeo_css | took 1117110ms 12:07:51 INFO - TEST-START | kraken 12:07:51 INFO - operating with platform_type : linux_ 12:07:51 INFO - Initialising browser for kraken test... 12:07:51 INFO - TEST-INFO | started process 6087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKPWYP/profile http://localhost:52338/getInfo.html) 12:07:56 INFO - PROCESS | 6087 | __metrics Screen width/height:1600/1200 12:07:56 INFO - PROCESS | 6087 | colorDepth:24 12:07:56 INFO - PROCESS | 6087 | Browser inner width/height: 1024/697 12:07:56 INFO - PROCESS | 6087 | __metrics 12:07:57 ERROR - PROCESS | 6087 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:07:57 INFO - TEST-INFO | 6087: exit 0 12:07:57 INFO - Browser initialized. 12:07:57 INFO - Running cycle 1/1 for kraken test... 12:07:57 INFO - TEST-INFO | started process 6171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKPWYP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:09 INFO - PROCESS | 6171 | RSS: Main: 154812416 12:08:09 INFO - PROCESS | 6171 | 12:08:12 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52338/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:13 INFO - PROCESS | 6171 | RSS: Main: 196395008 12:08:13 INFO - PROCESS | 6171 | 12:08:16 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52338/tests/kraken/driver.html?testName=audio-dft) 12:08:16 INFO - PROCESS | 6171 | RSS: Main: 186675200 12:08:16 INFO - PROCESS | 6171 | 12:08:19 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52338/tests/kraken/driver.html?testName=audio-fft) 12:08:20 INFO - PROCESS | 6171 | RSS: Main: 172617728 12:08:20 INFO - PROCESS | 6171 | 12:08:22 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52338/tests/kraken/driver.html?testName=audio-oscillator) 12:08:22 INFO - PROCESS | 6171 | RSS: Main: 172691456 12:08:22 INFO - PROCESS | 6171 | 12:08:25 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:25 INFO - PROCESS | 6171 | RSS: Main: 173367296 12:08:25 INFO - PROCESS | 6171 | 12:08:28 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52338/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:29 INFO - PROCESS | 6171 | RSS: Main: 174292992 12:08:29 INFO - PROCESS | 6171 | 12:08:32 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52338/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:33 INFO - PROCESS | 6171 | RSS: Main: 174870528 12:08:33 INFO - PROCESS | 6171 | 12:08:36 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52338/tests/kraken/driver.html?testName=json-parse-financial) 12:08:36 INFO - PROCESS | 6171 | RSS: Main: 174669824 12:08:36 INFO - PROCESS | 6171 | 12:08:38 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:39 INFO - PROCESS | 6171 | RSS: Main: 187633664 12:08:39 INFO - PROCESS | 6171 | 12:08:41 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:41 INFO - PROCESS | 6171 | RSS: Main: 184127488 12:08:41 INFO - PROCESS | 6171 | 12:08:43 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:44 INFO - PROCESS | 6171 | RSS: Main: 196071424 12:08:44 INFO - PROCESS | 6171 | 12:08:46 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:47 INFO - PROCESS | 6171 | RSS: Main: 199966720 12:08:47 INFO - PROCESS | 6171 | 12:08:49 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:50 INFO - PROCESS | 6171 | RSS: Main: 197509120 12:08:50 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | Cycle 1(1): loaded http://localhost:52338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52338/tests/kraken/driver.html?testName=ai-astar) 12:08:52 INFO - PROCESS | 6171 | RSS: Main: 259158016 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | __start_tp_report 12:08:52 INFO - PROCESS | 6171 | _x_x_mozilla_page_load 12:08:52 INFO - PROCESS | 6171 | _x_x_mozilla_page_load_details 12:08:52 INFO - PROCESS | 6171 | |i|pagename|runs| 12:08:52 INFO - PROCESS | 6171 | |0;ai-astar;111;113;109;111;112;114;101;112;110;112 12:08:52 INFO - PROCESS | 6171 | |1;audio-beat-detection;184;130;155;186;135;155;163;132;176;130 12:08:52 INFO - PROCESS | 6171 | |2;audio-dft;161;163;160;161;160;161;161;161;162;162 12:08:52 INFO - PROCESS | 6171 | |3;audio-fft;73;73;112;97;75;75;73;132;109;74 12:08:52 INFO - PROCESS | 6171 | |4;audio-oscillator;93;93;144;94;95;94;135;94;94;138 12:08:52 INFO - PROCESS | 6171 | |5;imaging-gaussian-blur;119;118;119;119;117;118;117;118;117;116 12:08:52 INFO - PROCESS | 6171 | |6;imaging-darkroom;147;147;147;147;146;146;147;147;147;147 12:08:52 INFO - PROCESS | 6171 | |7;imaging-desaturate;95;96;96;96;95;95;95;96;95;96 12:08:52 INFO - PROCESS | 6171 | |8;json-parse-financial;65;65;64;65;64;64;65;75;64;62 12:08:52 INFO - PROCESS | 6171 | |9;json-stringify-tinderbox;65;65;64;64;66;65;67;64;65;65 12:08:52 INFO - PROCESS | 6171 | |10;stanford-crypto-aes;80;81;83;81;83;82;81;82;82;82 12:08:52 INFO - PROCESS | 6171 | |11;stanford-crypto-ccm;126;117;119;116;123;117;120;117;114;116 12:08:52 INFO - PROCESS | 6171 | |12;stanford-crypto-pbkdf2;147;152;138;159;140;130;139;138;141;139 12:08:52 INFO - PROCESS | 6171 | |13;stanford-crypto-sha256-iterative;68;67;66;66;70;65;66;65;66;67 12:08:52 INFO - PROCESS | 6171 | __end_tp_report 12:08:52 INFO - PROCESS | 6171 | __start_cc_report 12:08:52 INFO - PROCESS | 6171 | _x_x_mozilla_cycle_collect,1137 12:08:52 INFO - PROCESS | 6171 | __end_cc_report 12:08:52 INFO - PROCESS | 6171 | __startTimestamp1458846532561__endTimestamp 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | ------- Summary: start ------- 12:08:52 INFO - PROCESS | 6171 | Number of tests: 14 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.63 (3.2%) stddev-sans-first:3.84 12:08:52 INFO - PROCESS | 6171 | Values: 111.0 113.0 109.0 111.0 112.0 114.0 101.0 112.0 110.0 112.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:159.00 stddev:22.32 (14.0%) stddev-sans-first:20.99 12:08:52 INFO - PROCESS | 6171 | Values: 184.0 130.0 155.0 186.0 135.0 155.0 163.0 132.0 176.0 130.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:08:52 INFO - PROCESS | 6171 | Values: 161.0 163.0 160.0 161.0 160.0 161.0 161.0 161.0 162.0 162.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#3] audio-fft Cycles:10 Average:89.30 Median:73.50 stddev:21.67 (29.5%) stddev-sans-first:22.17 12:08:52 INFO - PROCESS | 6171 | Values: 73.0 73.0 112.0 97.0 75.0 75.0 73.0 132.0 109.0 74.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.92 (23.3%) stddev-sans-first:22.62 12:08:52 INFO - PROCESS | 6171 | Values: 93.0 93.0 144.0 94.0 95.0 94.0 135.0 94.0 94.0 138.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 12:08:52 INFO - PROCESS | 6171 | Values: 119.0 118.0 119.0 119.0 117.0 118.0 117.0 118.0 117.0 116.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 12:08:52 INFO - PROCESS | 6171 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:08:52 INFO - PROCESS | 6171 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:3.53 (5.4%) stddev-sans-first:3.74 12:08:52 INFO - PROCESS | 6171 | Values: 65.0 65.0 64.0 65.0 64.0 64.0 65.0 75.0 64.0 62.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 12:08:52 INFO - PROCESS | 6171 | Values: 65.0 65.0 64.0 64.0 66.0 65.0 67.0 64.0 65.0 65.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:0.95 (1.2%) stddev-sans-first:0.78 12:08:52 INFO - PROCESS | 6171 | Values: 80.0 81.0 83.0 81.0 83.0 82.0 81.0 82.0 82.0 82.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.00 stddev:3.63 (3.1%) stddev-sans-first:2.65 12:08:52 INFO - PROCESS | 6171 | Values: 126.0 117.0 119.0 116.0 123.0 117.0 120.0 117.0 114.0 116.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:140.50 stddev:8.25 (5.9%) stddev-sans-first:8.57 12:08:52 INFO - PROCESS | 6171 | Values: 147.0 152.0 138.0 159.0 140.0 130.0 139.0 138.0 141.0 139.0 12:08:52 INFO - PROCESS | 6171 | 12:08:52 INFO - PROCESS | 6171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.51 (2.3%) stddev-sans-first:1.51 12:08:52 INFO - PROCESS | 6171 | Values: 68.0 67.0 66.0 66.0 70.0 65.0 66.0 65.0 66.0 67.0 12:08:52 INFO - PROCESS | 6171 | -------- Summary: end -------- 12:08:52 INFO - PROCESS | 6171 | 12:08:53 INFO - TEST-INFO | 6171: exit 0 12:08:53 INFO - TEST-OK | kraken | took 62118ms 12:08:53 INFO - SUITE-END | took 1179s 12:08:53 INFO - Completed test suite (00:19:39) 12:08:53 INFO - javascript benchmark 12:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2572.344052266672, 2661.4544018476226, 2667.973320266799, 2681.7452342027514, 2698.8515631640257, 4672.742999135055, 4710.387649605551, 4711.858644240674, 4718.787654555545, 4755.6908800928, 4704.717716936986, 4730.0776348612035, 4742.264948932912, 4832.154372984731, 4832.516748325165, 4300.806463709125, 4313.2451820931365, 4360.127974405116, 4385.035292235703, 4431.202383570956, 4348.695591308609, 4378.058717375764, 4396.36252743352, 4399.560043995591, 4430.579094985971, 4261.808218630169, 4294.699371044013, 4303.91392172158, 4340.9798697306105, 4350.064736081726, 4338.739675619473, 4360.738355698668, 4362.934555981663, 4407.911841763179, 4413.602775750166, 4343.1965086458795, 4345.913081738379, 4351.129774045204, 4358.237308471036, 4378.978105109486, 4476.7090139140855, 4592.265237561974, 4643.791029403685, 4694.577488026094, 4731.858044258678, 5033.320501732256, 5062.620303477217, 5068.873278168038, 5111.361079865017, 5122.92315615266, 5006.4743201964, 5066.493350664941, 5086.669366491166, 5087.49125087492, 5093.0, 4707.670463067587, 4740.644451666139, 4756.096341695067, 4785.114753770494, 4788.640851936084, 5178.456262092502, 5219.660722053054, 5221.556167725786, 5228.9477105229225, 5277.8416647500635, 4904.485029071968, 4963.6277279204205, 5013.1227035268685, 5015.0, 5051.797928082836, 5023.82416615424, 5042.420121686053, 5044.596432285409, 5066.620003499752, 5090.338256026693, 4981.2030075187795, 4984.526469985346, 4989.101961646866, 4991.700497970133, 5040.974795126074, 4881.267809828554, 4943.8516844494725, 4963.925541116886, 4993.70037797726, 5011.974940125276, 4268.338407546835, 4279.3153095505195, 4280.122574872144, 4302.397664326997, 4312.978435107867, 3704.49989251453, 3735.0, 3740.17716102457, 3764.9247015059545, 3782.8486860525823, 4283.121959998255, 4312.719673221231, 4349.586789255016, 4368.104538569585, 4396.934045989313, 5128.3076784633595, 5133.307003554547, 5141.3830340358645, 5147.6911385317, 5156.097682905552, 4388.0, 4394.384786129945, 4395.055063161436, 4413.867583972486, 4448.822047118144, 4470.463544374696, 4538.863834084983, 4588.816447342136, 4600.171969045537, 4615.23848564983, 4761.40482439695, 4775.570198682135, 4791.0178413425165, 4794.448638406628, 4839.685420447659, 5058.089543882136, 5086.0, 5104.05574968632, 5106.642535022513, 5153.639245252946, 4649.558291962258, 4763.333133361401, 4811.398575178103, 4832.855014349575, 4834.299026641047, 4999.200127979506, 5019.548240658358, 5025.673331233458, 5036.471170527042, 5087.008033433445, 4900.995295964248, 5089.923651145162, 5115.335006449138, 5123.641345105956, 5126.957971848964, 4915.238138088459, 4927.457979622167, 4953.554180123806, 4991.0, 5000.6249531284575, 4939.728314942713, 4968.801247950041, 4969.82605608802, 4975.4278258000795, 5014.623903207201, 4795.496472870298, 4820.517948205152, 4901.313816065683, 4902.828401005948, 4968.0, 4921.557059864629, 4947.406311242674, 4950.801967921243, 4976.651634385558, 4995.825146119869, 4823.3729615149805, 4824.517548245148, 4829.468758436499, 4830.879228019187, 4879.4876537963], "unit": "score", "name": "dojo.html", "value": 4652.138076830086}, {"lowerIsBetter": false, "replicates": [495.23733450486253, 521.4055976187146, 535.8928214357124, 538.8060298292617, 541.226046753143, 27498.31254218643, 27919.44161116779, 33863.66136338639, 34292.0, 34372.828135859345, 37824.43263351045, 38406.423903641466, 38406.8079659602, 38460.42309365362, 38478.807605962, 7693.230676932318, 7854.0, 7884.921150788505, 7885.723999660013, 7886.881696774553, 7721.884171737428, 7834.72578459754, 7845.254700803414, 7846.960765196166, 7847.725329613465, 7984.3213326867, 8073.515589064675, 8075.636596353178, 8078.232567906069, 8078.515289082674, 7973.32226760726, 8008.719694810712, 8048.557329346883, 8054.798630034237, 8063.354931605458, 7936.365090792723, 8051.677932882678, 8079.676812927476, 8087.47431416956, 8090.069641991128, 38872.22255554873, 39246.607533924864, 39352.21295574101, 39367.60632393668, 39397.212055758726, 3179.8887038953526, 3397.8640854365794, 3611.2416392557593, 3681.576618688858, 3956.268090403256, 29850.85074574635, 29888.0, 30480.0, 30509.694903050906, 30654.386912261853, 3403.9659603403898, 3412.3516531859113, 3459.844307006191, 3475.8609655613745, 3523.312953973976, 257098.0, 259365.0, 259533.0, 259961.9999999981, 260072.0, 41534.0, 57788.0, 58979.0, 59007.40992590019, 59132.0, 39768.80115599462, 39923.60076399199, 40064.799676001436, 40086.79956600257, 40160.39759403611, 14651.853481465261, 14703.117812931258, 14898.925505372405, 14911.478098266509, 14931.776023359658, 11660.53357865676, 11710.297382157098, 11714.531418743154, 11733.882661173278, 11753.353565553976, 14731.337089830984, 14751.631209219855, 14789.778153327708, 14900.019996000843, 15037.398504059935, 5625.184348269478, 5752.0, 5867.911981320283, 5867.970660146757, 5885.440883116097, 913.488446469979, 920.6593560382702, 967.1295833749682, 989.317371013998, 1011.9038691324313, 26475.735242647712, 27283.0, 27770.166894992777, 27945.580816287773, 28042.579361309596, 876.7501262140387, 998.4159266828841, 1003.1673710820002, 1087.0977089016255, 1093.781243751253, 12921.483140674267, 13090.14914030585, 13203.73592528144, 13235.801462978063, 13261.204327740366, 301941.0, 304155.0, 304995.0, 305665.0184734322, 305669.0, 44508.55491445109, 44962.0, 44967.32549011702, 45080.77459612681, 45100.999999999345, 1044.8902865199045, 1124.8425220469142, 1199.280431740966, 1218.945147468366, 1223.4066477758458, 25033.74966250387, 27019.86490067537, 27071.0, 27355.0, 27665.170044898685, 38135.618643813206, 38543.22913541769, 38646.806765965994, 38648.613513864504, 38668.2266354677, 209798.0, 215126.0, 215170.0, 215344.0, 234202.0, 30317.0, 30816.84591577028, 31099.84450077735, 31632.209194770316, 31633.5254971171, 35369.0, 36181.27637447289, 36397.45403818892, 36460.45309320309, 36688.44967325439, 29537.852310738308, 30379.392412152076, 30439.239019024702, 30494.0, 30683.693163068976, 30544.236394090327, 31245.843770781, 31736.0, 33205.33589328152, 33260.0, 32515.674843251265, 33024.1743956403, 33119.172020699676, 33299.83350083234, 33392.49911251284, 29516.852415737783, 30120.849395753758, 30168.189908605553, 30418.239544010692, 30500.847495763268, 23726.525469490858, 23912.0, 23960.15734673335, 24018.15936442216, 24331.39171520726], "unit": "score", "name": "ext.html", "value": 16601.886837206443}, {"lowerIsBetter": false, "replicates": [351.3815684395463, 352.654622614725, 360.2039492721087, 363.5782492308922, 368.53932584269666, 15376.769348459782, 15843.920780396096, 16090.1954902255, 16431.507054788344, 16462.176891155425, 15601.14193719345, 16093.0, 16248.51254462368, 16249.593760156002, 16284.0, 5070.0, 5200.063988482072, 5234.450382709818, 6415.935840641604, 6792.083068785725, 6699.497537684669, 6722.361375669304, 6725.024871393645, 6764.7970560883, 6767.830804229909, 6502.70737816797, 6728.0, 6757.932420675804, 6760.628165450898, 6772.0, 6652.900206496906, 6717.529772915874, 6736.023276624911, 6745.8650826983185, 6758.560693554928, 6125.632462052291, 6381.329960354143, 6387.297397286295, 6388.872222555569, 6389.808305750835, 20798.16807327705, 20802.687959680617, 22621.547569048693, 22640.77359226403, 22682.432939176488, 2041.612093702192, 2198.560287942402, 2225.2100504320897, 2234.218023691711, 2277.487565297811, 13200.603981880558, 13830.0, 14187.219702916336, 14507.637309067357, 14709.852901470955, 1941.1167918597005, 1973.6546104431668, 1973.6940774180025, 1996.0, 2047.9590408191902, 47894.0, 48153.51846481526, 49926.07688004471, 50894.0, 59520.70239648774, 14806.703865922622, 15112.471063512725, 15216.695666086838, 15340.156291403857, 15384.923075384775, 21353.572928541344, 23249.418764530685, 24254.272371828873, 24469.265922022012, 24516.754832451803, 8697.869531957025, 8750.387472876837, 8814.691485797966, 8862.246709029676, 9033.683821066232, 7496.175420703718, 7589.316961473383, 7631.961840190764, 7660.655270512729, 7740.380769538423, 7396.519226250277, 7547.849043019109, 7558.924410755932, 7622.390208783284, 7741.683913734679, 2985.5220167261123, 3051.925679218224, 3063.973568854459, 3117.719405253538, 3136.48248039071, 832.4464231286248, 861.237804542984, 881.1716986033236, 961.0053594529628, 973.4013581647235, 16170.919145404197, 16412.1793910304, 16529.0, 16690.664746820225, 16888.49334519942, 856.8157846063002, 873.2708188662411, 894.9731508054768, 896.8027034052498, 905.8550631898864, 9374.95312523433, 9393.718188454357, 9521.333506654606, 9544.95227523858, 9680.27397945143, 402656.0, 411455.0, 414330.0, 418277.0, 419770.0, 66708.6664566674, 68731.40857392826, 68995.0, 69361.3063869365, 70212.2978770216, 948.6869333120054, 958.2669258017622, 974.3958745577787, 988.6687959533493, 1003.7139415266614, 14369.56891293263, 14711.852881471048, 14828.406863725762, 14860.925695371454, 15164.772528411862, 23805.880970595037, 31209.0, 32198.678013220506, 32440.0, 32845.0, 40189.79905100456, 43035.569644303156, 43138.78430607827, 43366.132677345646, 44297.0, 7289.161746399232, 7475.289847464483, 7654.770356889302, 7697.807554811175, 7708.344790692854, 8808.647654093764, 11550.191486595857, 11655.242409243372, 11680.948714615726, 11845.170838041598, 10156.17188906004, 10292.536835842555, 10327.32872363294, 10356.119729823049, 10371.688849334532, 10044.899551004397, 10100.949495252476, 10133.290669653054, 10241.0, 10429.26995110335, 10081.344712593658, 10284.897151028394, 10388.636397726043, 10399.0, 10417.687469375627, 7228.96385518069, 7229.349358557755, 7344.491631276543, 7494.437917156344, 7499.6875546778, 9030.729078127666, 9764.951175244078, 10007.149392301735, 10043.146332561813, 10219.437930913573], "unit": "score", "name": "jquery.html", "value": 8938.113805376148}, {"lowerIsBetter": false, "replicates": [1320.775468170411, 1431.148466662336, 1448.398914450503, 1590.9124998125099, 1802.414215380002, 7409.407247420207, 7671.232876712326, 7677.692892284302, 7679.500832445887, 7679.692812287516, 7507.662155203016, 7689.346405555534, 7703.1526532081425, 7707.383409327254, 7709.768706938787, 1979.3171355882198, 2019.7475315585552, 2022.0698478699817, 2267.716535433075, 2304.28567144185, 2230.966535501969, 2304.804091652203, 2305.3429772514837, 2306.2043594959714, 2307.8384513084093, 2171.6308227601266, 2215.2025270902463, 2242.585121752481, 2248.3592176229777, 2258.3563684349965, 2229.4537838229576, 2236.6980457638256, 2238.46276893546, 2238.787315205053, 2240.809531189851, 2184.7050648162453, 2211.955760884773, 2220.911163553456, 2222.377734234417, 2232.2745107839855, 7811.882821757678, 7840.333571646417, 7846.058472983222, 7847.882281765778, 7858.724944626968, 4632.8146874125, 4711.882202944919, 4716.811327546894, 4754.548317909793, 4756.66703330767, 3003.7840639086376, 3121.7658675599196, 3124.281415274477, 3141.5601815745813, 3168.7940283881476, 974.3325821812082, 1014.7818219082933, 1022.6318525330875, 1047.6176195688595, 1048.3343077145992, 10610.0, 10812.78374432507, 10815.78368432627, 10817.0, 10820.621278255223, 4264.0832221072, 4267.1892340455215, 4371.803268852909, 4374.256376416017, 4377.737335759864, 9276.11876871696, 9288.164065234027, 9303.674371396968, 9317.72046838596, 9361.344705870524, 4736.1474934511425, 4738.810447582127, 4760.047990401933, 4764.809407623726, 4771.928421073687, 3729.216864458494, 4105.85629502966, 4223.831046758095, 4297.871063868089, 4307.741535507879, 3598.7660802047785, 3619.1856832212543, 3671.247394284219, 3673.3020726061964, 3697.0757310672334, 1211.7818792617238, 1215.750771091924, 1224.3755684600917, 1229.3791635224154, 1247.52594014274, 1201.897838683704, 1202.7654607351658, 1222.896053835416, 1230.2126638951079, 1258.24505296823, 7155.785326440215, 7172.13934327884, 7198.964005180045, 7239.167495737952, 7421.962890185622, 1022.616518805448, 1040.7450174707244, 1051.3271506236015, 1057.8677665291839, 1061.623123791043, 5657.886842263131, 5674.801381951612, 5710.885782284414, 5727.828165155052, 5734.082546792577, 8839.983401908734, 9363.531823408803, 9384.0, 9421.90578094224, 9514.571844266886, 9227.53862306882, 9250.537473126316, 9259.02780208082, 9457.054294570487, 9542.0, 6969.372756451944, 7131.536450130725, 7165.7850264492145, 7199.89200161998, 7336.7065317386705, 6972.860542789014, 6997.300269972962, 7013.2986701329455, 7018.613976231356, 7045.401140902875, 8285.917140828515, 8468.237858592756, 8492.787680308042, 8706.434081784664, 8718.738437846874, 8650.0, 8777.473351598925, 8782.736517904474, 8962.32782541299, 8978.416402933788, 6000.129981152621, 6551.475881929529, 6711.261761206166, 6819.386255237053, 6953.478489113438, 7261.818454538678, 7270.6728197230195, 7272.854542909218, 7301.050863387938, 7302.269773022867, 6499.155109835691, 6673.032410300382, 6675.0, 6761.256261811099, 6840.384365407137, 6483.935160648522, 6675.566088204251, 6703.463722902254, 6752.392284694204, 6825.419839313714, 6993.895091573732, 7019.157701075904, 7081.433485321265, 7086.362227399559, 7092.716291348494, 6426.4216220540375, 6480.222373315232, 6484.027395890655, 6503.73985040612, 6558.967205163944, 6665.500087493554, 6727.596344219362, 6728.125343705287, 6728.158980127484, 6732.259451460433], "unit": "score", "name": "mootools.html", "value": 4464.328060043126}, {"lowerIsBetter": false, "replicates": [319.0460523036122, 321.5642804000579, 322.0419252723148, 322.6338106249406, 324.24127541552764, 5301.284326615906, 5338.572914166863, 5351.277577527033, 5398.514133727964, 5424.972875135629, 5319.627626066177, 5335.5198032177095, 5337.1994200869885, 5337.866553336168, 5349.732513374325, 3931.7640941543455, 4018.5981401859726, 4141.979290103545, 4143.212789569972, 4174.206900688874, 4180.581941805825, 4181.121964387482, 4182.2890108681595, 4182.686298527623, 4189.748615083105, 4133.1940271647045, 4133.441985331987, 4133.689973252003, 4136.5242997055275, 4141.440905477767, 3944.15200731844, 4017.738846974937, 4131.194417088669, 4145.108801607654, 4165.0, 3664.450332450127, 3669.504616876714, 3678.5769636491877, 3678.8528458861615, 3686.6681998619983, 5120.206368012927, 5128.538431541179, 5140.177571588565, 5148.304978827885, 5153.458886816905, 4807.0, 4815.5906747926465, 4818.084563932876, 4819.662623616348, 4830.806767729287, 5627.127795191752, 5631.267935168402, 5635.436456354373, 5639.351474580394, 5642.605017648766, 4034.4755181826467, 4039.858604948842, 4041.2523683118716, 4044.090079732066, 4046.5953404659595, 5729.656220626775, 5895.911561326584, 5902.61632993854, 5910.995130827727, 5919.260092488439, 4131.483564554431, 4147.917041659211, 4149.398337241083, 4152.6055024772595, 4155.563665815046, 4198.748075115503, 4211.936820947688, 4212.662986961036, 4214.831406743696, 4218.78906054696, 4750.429948406213, 4777.689450185727, 4780.426348838092, 4782.282657601388, 4783.976080119647, 5629.43705629442, 5636.50632582366, 5637.859053523613, 5638.464345887216, 5644.491995720405, 1465.4065103633045, 1492.3359105198083, 1493.0668332292316, 1494.783256427812, 1497.8352381238055, 887.245841035115, 914.2274777812737, 948.4735971535864, 956.4309236004566, 1011.2415688233824, 4800.087983283165, 4907.2393778964315, 4914.0171965606305, 4918.213085906309, 4920.483349248278, 5796.536277097822, 5922.2597175353085, 5959.910601340984, 5963.7912673056235, 5979.850503737442, 4956.876078098005, 4957.826476073392, 4960.255961605716, 4961.08219979305, 4967.453580106186, 3122.4847900096684, 3159.605049368829, 3164.3196712706417, 3168.413843438971, 3168.7940283881476, 5503.367112782002, 5505.449455054462, 5508.807191748349, 5516.310461192351, 5518.862028449241, 5869.178315035899, 6041.72812223451, 6051.909221361683, 6052.697365131726, 6056.848578785565, 5466.9179962300595, 5480.369757477862, 5481.451854814487, 5490.450954904478, 5496.917546236729, 5870.5010074144175, 5874.0, 5875.294964604275, 5877.471027607536, 5882.941170588239, 5741.339745929272, 5741.856453588526, 5744.396838332083, 5749.798757043483, 5750.166225897138, 5485.314335708036, 5498.615096943336, 5499.340079190522, 5502.669839809624, 5507.091329930677, 3919.549251836075, 4023.557408684984, 4027.7180597357906, 4032.4556184915837, 4042.0703238254778, 5842.328132264844, 5866.618669786621, 5868.735906884286, 5871.970640146772, 5882.911756323573, 5647.774089036557, 5654.180143879033, 5658.490735833795, 5659.603827732019, 5660.886782264414, 5590.468905453975, 5600.159976003632, 5603.35561410443, 5618.52242559387, 5647.378788333198, 5556.777728890799, 5574.832755017356, 5579.442055794388, 5584.636998595079, 5598.10430331145, 5489.725513724377, 5657.038303488334, 5657.236273103078, 5665.12190610456, 5667.574931880043, 5454.727263636882, 5553.639358357228, 5573.832785016456, 5577.944220557904, 5578.107502799533], "unit": "score", "name": "prototype.html", "value": 4252.007856951524}, {"lowerIsBetter": false, "replicates": [686.5228666077077, 725.2312548698384, 772.4592785050464, 778.2956424435883, 792.3225642076025, 11923.880761192386, 12017.339046352447, 12112.333821639806, 12213.755724885508, 12268.877311226885, 11223.887761122387, 11290.943545282262, 11346.773064538704, 11400.828987565194, 11517.539298428073, 659.9043138744879, 815.4169768615468, 817.9059408168048, 836.1137194573771, 840.1010918317403, 830.1822704635929, 833.6373677450298, 833.9416240863142, 836.1053672570353, 836.6862426590029, 861.9741407757746, 866.4498043742237, 867.3104881619128, 867.5228624256665, 867.7830542364409, 688.4939569416475, 840.1220724343045, 861.1775754154767, 862.7929296968745, 862.8835107260534, 629.3989240275525, 629.8992161254223, 630.0612087988909, 630.9463695585881, 630.9872654389684, 11622.360770157638, 11656.0, 11666.125040621902, 11703.0, 11751.764964700744, 11925.821112683318, 12226.266424014588, 12296.692582685415, 12482.313472758995, 12800.359982000862, 10046.185920775672, 10210.9489452553, 10215.02957219063, 10232.539535720836, 10360.481975901175, 3361.3277344531193, 3399.9150021249666, 3405.080628230364, 3444.913877153066, 3455.0498612881406, 42570.0, 42650.36024459604, 42782.0, 42810.0, 42841.35737963933, 9917.404955702681, 10056.849147262797, 10066.496675166212, 10075.496225188712, 10609.416482093558, 15737.0, 15815.0, 15816.209189540477, 15818.209089545477, 15833.52499425019, 6685.431738302299, 6710.254816656308, 6746.628935408501, 6808.114945057111, 6914.9308506914285, 3794.222184452236, 3827.2919509890758, 3867.8646247381207, 3884.2814079395403, 3893.4354518594646, 2806.396624725653, 2903.332233586287, 2908.34562223498, 2918.5330347144354, 2919.9562006569918, 484.15273271774396, 515.1191462598923, 520.7005971566289, 529.068838843638, 538.5072658517491, 523.8635182040133, 555.1506195520859, 590.630855715178, 610.4505944649851, 637.4995628431659, 8201.630926608317, 8231.588420578948, 8267.503949763033, 8283.917160828314, 8485.321174306164, 566.7166416791604, 579.2209478251744, 627.7143899525705, 654.3783405764543, 663.7278715726626, 3345.9665403346144, 3826.521684789401, 3885.9160478558097, 3935.4293627424436, 3976.0, 52377.7381113092, 53156.20265696017, 53170.73414632979, 53239.46760532423, 53322.20016699753, 45944.54055459469, 46673.29990050152, 46971.76514117407, 47393.28910066352, 47839.0, 41579.58420415818, 41617.791911040855, 41995.0, 42154.99999999939, 42487.36268955968, 8664.870026949475, 8857.468551886908, 8876.245519130945, 8912.465252084896, 8921.973972993188, 30550.847245763627, 31028.98311609738, 31624.683753162175, 31777.364452711277, 31881.521777172897, 35864.0, 39172.80413597914, 40300.0, 40533.39199911945, 41896.581034189265, 9613.567389467351, 9707.563159657973, 10276.332038417479, 10669.41318227505, 10855.620053298097, 11601.709957251136, 11622.88377116218, 11676.591319303783, 11767.0, 12292.877071229532, 11044.017241293286, 11289.266197697452, 11412.201145919706, 11651.941740291244, 11925.284482931052, 11244.437778110898, 11391.658250252174, 11708.765824683629, 11729.941350293195, 11969.10231732641, 10793.190510711886, 11017.724556886142, 11238.325700458, 11509.13681473876, 11535.36555489456, 9422.811543769223, 9651.131398173917, 9693.6122555097, 9857.11285984265, 10037.046480584333, 9564.4739539326, 9592.712218633453, 9635.807283854423, 9652.806943861224, 9654.75863103428], "unit": "score", "name": "yui.html", "value": 5980.385011159134}], "name": "dromaeo_css", "value": 6541.7835749834185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 109.0, 111.0, 112.0, 114.0, 101.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [184.0, 130.0, 155.0, 186.0, 135.0, 155.0, 163.0, 132.0, 176.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 154.6}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 112.0, 97.0, 75.0, 75.0, 73.0, 132.0, 109.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 94.0, 95.0, 94.0, 135.0, 94.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 119.0, 119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 75.0, 64.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 67.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 83.0, 81.0, 83.0, 82.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [126.0, 117.0, 119.0, 116.0, 123.0, 117.0, 120.0, 117.0, 114.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [147.0, 152.0, 138.0, 159.0, 140.0, 130.0, 139.0, 138.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 70.0, 65.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1522.4999999999998}]} 12:08:53 INFO - Return code: 0 12:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:08:53 ERROR - # TBPL SUCCESS # 12:08:53 INFO - Running post-action listener: _resource_record_post_action 12:08:53 INFO - Running post-run listener: _resource_record_post_run 12:08:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 288288768; Read time: 0; Write time: 305676 12:08:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9506816; Read time: 0; Write time: 5740 12:08:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 278781952; Read time: 0; Write time: 299936 12:08:54 INFO - Running post-run listener: _upload_blobber_files 12:08:54 INFO - Blob upload gear active. 12:08:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:56 INFO - (blobuploader) - INFO - Done attempting. 12:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:57 INFO - (blobuploader) - INFO - Done attempting. 12:08:57 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:57 INFO - Return code: 0 12:08:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/412886077c56ac503fc0c71c1a6247badf53c37947a1874531ef32d19a45c4335b53499517c3074bdf3b681ff710c9de07b8e25f266e44150b7b478f16de3814", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8001d944c22a893d4a97fc4dfd29e5cac481c42f3a21c347d72f5c3d4d731fb992bede4b2a853c30d334da5f139b2ec51a98812b4e8d14866b2f51471b1aa80a"} 12:08:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:57 INFO - Contents: 12:08:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/412886077c56ac503fc0c71c1a6247badf53c37947a1874531ef32d19a45c4335b53499517c3074bdf3b681ff710c9de07b8e25f266e44150b7b478f16de3814", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8001d944c22a893d4a97fc4dfd29e5cac481c42f3a21c347d72f5c3d4d731fb992bede4b2a853c30d334da5f139b2ec51a98812b4e8d14866b2f51471b1aa80a"} 12:08:57 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:57 INFO - Copying logs to upload dir... 12:08:57 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.154069 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-24 12:08:56.400440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 12:08:56.405605) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 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/412886077c56ac503fc0c71c1a6247badf53c37947a1874531ef32d19a45c4335b53499517c3074bdf3b681ff710c9de07b8e25f266e44150b7b478f16de3814", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8001d944c22a893d4a97fc4dfd29e5cac481c42f3a21c347d72f5c3d4d731fb992bede4b2a853c30d334da5f139b2ec51a98812b4e8d14866b2f51471b1aa80a"} build_url:https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/FBRGsI16QXKYDcV0lFuXow/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/412886077c56ac503fc0c71c1a6247badf53c37947a1874531ef32d19a45c4335b53499517c3074bdf3b681ff710c9de07b8e25f266e44150b7b478f16de3814", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8001d944c22a893d4a97fc4dfd29e5cac481c42f3a21c347d72f5c3d4d731fb992bede4b2a853c30d334da5f139b2ec51a98812b4e8d14866b2f51471b1aa80a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 12:08:56.432459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 12:08:56.432795) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1458845260.349269-209368677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 12:08:56.515424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 12:08:56.515765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 12:08:56.516092) ========= ========= Total master_lag: 2.32 =========