builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1460501953.62 results: success (0) buildid: 20160412151348 builduid: 1c4de7b74d2b49aabb61200b3bf25527 revision: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.620002) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.620389) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.620674) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006400 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.646239) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.646514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.659457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.659716) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.708471) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.708741) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.709116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.709392) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 15:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.1M=0s 2016-04-12 15:59:13 (97.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.830895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.831185) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021681 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.889059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.889366) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 --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 f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 15:59:14,030 truncating revision to first 12 chars 2016-04-12 15:59:14,030 Setting DEBUG logging. 2016-04-12 15:59:14,030 attempt 1/10 2016-04-12 15:59:14,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6241b9dc0e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 15:59:14,635 unpacking tar archive at: fx-team-f6241b9dc0e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.785278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.785586) ========= echo f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f6241b9dc0e90b1a7b418142c3a12202ebfc0df4'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 program finished with exit code 0 elapsedTime=0.004768 script_repo_revision: 'f6241b9dc0e90b1a7b418142c3a12202ebfc0df4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.841893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.842600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.852795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-12 15:59:14.853090) ========= /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=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:59:15 INFO - MultiFileLogger online at 20160412 15:59:15 in /builds/slave/test 15:59:15 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 15:59:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:59:15 INFO - {'append_to_log': False, 15:59:15 INFO - 'base_work_dir': '/builds/slave/test', 15:59:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:59:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:59:15 INFO - 'branch': 'Fx-Team-Non-PGO', 15:59:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:15 INFO - 'config_files': ('talos/linux_config.py',), 15:59:15 INFO - 'default_actions': ('clobber', 15:59:15 INFO - 'read-buildbot-config', 15:59:15 INFO - 'download-and-extract', 15:59:15 INFO - 'populate-webroot', 15:59:15 INFO - 'create-virtualenv', 15:59:15 INFO - 'install', 15:59:15 INFO - 'run-tests'), 15:59:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:15 INFO - 'download_minidump_stackwalk': True, 15:59:15 INFO - 'download_symbols': 'ondemand', 15:59:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:15 INFO - 'installer_path': 'installer.exe', 15:59:15 INFO - 'log_level': 'info', 15:59:15 INFO - 'log_name': 'talos', 15:59:15 INFO - 'log_to_console': True, 15:59:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:59:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:59:15 INFO - 'opt_config_files': (), 15:59:15 INFO - 'pip_index': False, 15:59:15 INFO - 'sps_profile': False, 15:59:15 INFO - 'sps_profile_interval': 0, 15:59:15 INFO - 'suite': 'dromaeojs', 15:59:15 INFO - 'system_bits': '32', 15:59:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:15 INFO - 'title': 'talos-linux64-ix-011', 15:59:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:15 INFO - 'use_talos_json': True, 15:59:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:59:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:15 INFO - 'work_dir': 'build'} 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running clobber step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: clobber 15:59:15 INFO - rmtree: /builds/slave/test/build 15:59:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running read-buildbot-config step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: read_buildbot_config 15:59:15 INFO - Using buildbot properties: 15:59:15 INFO - { 15:59:15 INFO - "project": "", 15:59:15 INFO - "product": "firefox", 15:59:15 INFO - "script_repo_revision": "production", 15:59:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:59:15 INFO - "repository": "", 15:59:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:59:15 INFO - "buildid": "20160412151348", 15:59:15 INFO - "pgo_build": "False", 15:59:15 INFO - "basedir": "/builds/slave/test", 15:59:15 INFO - "buildnumber": 2815, 15:59:15 INFO - "slavename": "talos-linux64-ix-011", 15:59:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:59:15 INFO - "platform": "ubuntu64_hw", 15:59:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:59:15 INFO - "branch": "fx-team", 15:59:15 INFO - "repo_path": "integration/fx-team", 15:59:15 INFO - "revision": "f6241b9dc0e90b1a7b418142c3a12202ebfc0df4", 15:59:15 INFO - "stage_platform": "linux64", 15:59:15 INFO - "builduid": "1c4de7b74d2b49aabb61200b3bf25527", 15:59:15 INFO - "slavebuilddir": "test" 15:59:15 INFO - } 15:59:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running download-and-extract step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: download_and_extract 15:59:15 INFO - mkdir: /builds/slave/test/build/tests 15:59:15 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')]} 15:59:15 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:18 INFO - Downloaded 1361 bytes. 15:59:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:18 INFO - Using the following test package requirements: 15:59:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:59:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'jsshell-linux-x86_64.zip'], 15:59:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:18 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')]} 15:59:18 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:20 INFO - Downloaded 22192969 bytes. 15:59:20 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'] 15:59:20 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 15:59:21 INFO - Return code: 0 15:59:21 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 15:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:21 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:22 INFO - Downloaded 22192969 bytes. 15:59:22 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'] 15:59:22 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 15:59:24 INFO - Return code: 0 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:24 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:26 INFO - Downloaded 10841076 bytes. 15:59:26 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'] 15:59:26 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 15:59:26 INFO - Return code: 0 15:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:26 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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 15:59:28 INFO - Downloaded 54147441 bytes. 15:59:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:28 INFO - mkdir: /builds/slave/test/properties 15:59:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:28 INFO - Contents: 15:59:28 INFO - build_url:https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:29 INFO - Running post-action listener: _resource_record_post_action 15:59:29 INFO - Running post-action listener: set_extra_try_arguments 15:59:29 INFO - ##### 15:59:29 INFO - ##### Running populate-webroot step. 15:59:29 INFO - ##### 15:59:29 INFO - Running pre-action listener: _resource_record_pre_action 15:59:29 INFO - Running main action method: populate_webroot 15:59:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:29 INFO - '--tppagecycles', 15:59:29 INFO - '7'], 15:59:29 INFO - 'tests': ['tsvgm']}}, 15:59:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:59:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:59:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['damp', 'tps']}, 15:59:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'tests': ['damp', 'tps']}, 15:59:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['dromaeo_dom']}, 15:59:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'other-e10s': {'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['a11yr', 15:59:29 INFO - 'ts_paint', 15:59:29 INFO - 'tpaint', 15:59:29 INFO - 'sessionrestore', 15:59:29 INFO - 'sessionrestore_no_auto_restore', 15:59:29 INFO - 'tabpaint']}, 15:59:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['tsvgx', 15:59:29 INFO - 'tsvgr_opacity', 15:59:29 INFO - 'tart', 15:59:29 INFO - 'tscrollx', 15:59:29 INFO - 'cart']}, 15:59:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:59:29 INFO - 'tsvgr_opacity', 15:59:29 INFO - 'tart', 15:59:29 INFO - 'tscrollx', 15:59:29 INFO - 'cart']}, 15:59:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'talos_options': ['--disable-e10s'], 15:59:29 INFO - 'tests': ['tp5o']}, 15:59:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'tests': ['tp5o']}, 15:59:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'talos_options': ['--disable-e10s', 15:59:29 INFO - '--xperf_path', 15:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:29 INFO - 'tests': ['tp5n']}, 15:59:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:29 INFO - 'talos_options': ['--xperf_path', 15:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:29 INFO - 'tests': ['tp5n']}}, 15:59:29 INFO - 'talos.zip': {'path': '', 15:59:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:29 INFO - Running post-action listener: _resource_record_post_action 15:59:29 INFO - ##### 15:59:29 INFO - ##### Running create-virtualenv step. 15:59:29 INFO - ##### 15:59:29 INFO - Running pre-action listener: _resource_record_pre_action 15:59:29 INFO - Running main action method: create_virtualenv 15:59:29 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:29 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 15:59:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:29 INFO - Using real prefix '/usr' 15:59:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:32 INFO - Installing pip.................done. 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:32 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')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:32 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 15:59:32 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 15:59:32 INFO - Using env: {'DISPLAY': ':0', 15:59:32 INFO - 'HOME': '/home/cltbld', 15:59:32 INFO - 'LANG': 'en_US.UTF-8', 15:59:32 INFO - 'LANGUAGE': 'en_US:en', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MAIL': '/var/mail/cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SHLVL': '1', 15:59:32 INFO - 'TERM': 'linux', 15:59:32 INFO - 'TMOUT': '86400', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - '_': '/tools/buildbot/bin/python'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 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 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:59:32 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')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:32 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 15:59:32 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 15:59:32 INFO - Using env: {'DISPLAY': ':0', 15:59:32 INFO - 'HOME': '/home/cltbld', 15:59:32 INFO - 'LANG': 'en_US.UTF-8', 15:59:32 INFO - 'LANGUAGE': 'en_US:en', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MAIL': '/var/mail/cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SHLVL': '1', 15:59:32 INFO - 'TERM': 'linux', 15:59:32 INFO - 'TMOUT': '86400', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - '_': '/tools/buildbot/bin/python'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 INFO - Downloading/unpacking psutil>=0.7.1 15:59:32 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 15:59:32 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 15:59:32 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 15:59:32 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 15:59:32 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 15:59:32 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 15:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:34 INFO - Installing collected packages: psutil 15:59:34 INFO - Running setup.py install for psutil 15:59:34 INFO - building 'psutil._psutil_linux' extension 15:59:34 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 15:59:34 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 15:59:34 INFO - building 'psutil._psutil_posix' extension 15:59:34 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 15:59:34 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 15:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:35 INFO - Successfully installed psutil 15:59:35 INFO - Cleaning up... 15:59:36 INFO - Return code: 0 15:59:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:59:36 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')]} 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 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')]} 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:36 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 15:59:36 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 15:59:36 INFO - Using env: {'DISPLAY': ':0', 15:59:36 INFO - 'HOME': '/home/cltbld', 15:59:36 INFO - 'LANG': 'en_US.UTF-8', 15:59:36 INFO - 'LANGUAGE': 'en_US:en', 15:59:36 INFO - 'LOGNAME': 'cltbld', 15:59:36 INFO - 'MAIL': '/var/mail/cltbld', 15:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:36 INFO - 'MOZ_NO_REMOTE': '1', 15:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:36 INFO - 'NO_EM_RESTART': '1', 15:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:36 INFO - 'PWD': '/builds/slave/test', 15:59:36 INFO - 'SHELL': '/bin/bash', 15:59:36 INFO - 'SHLVL': '1', 15:59:36 INFO - 'TERM': 'linux', 15:59:36 INFO - 'TMOUT': '86400', 15:59:36 INFO - 'USER': 'cltbld', 15:59:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:36 INFO - '_': '/tools/buildbot/bin/python'} 15:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:39 INFO - Installing collected packages: mozsystemmonitor 15:59:39 INFO - Running setup.py install for mozsystemmonitor 15:59:39 INFO - Successfully installed mozsystemmonitor 15:59:39 INFO - Cleaning up... 15:59:40 INFO - Return code: 0 15:59:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:40 INFO - Using env: {'DISPLAY': ':0', 15:59:40 INFO - 'HOME': '/home/cltbld', 15:59:40 INFO - 'LANG': 'en_US.UTF-8', 15:59:40 INFO - 'LANGUAGE': 'en_US:en', 15:59:40 INFO - 'LOGNAME': 'cltbld', 15:59:40 INFO - 'MAIL': '/var/mail/cltbld', 15:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:40 INFO - 'MOZ_NO_REMOTE': '1', 15:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:40 INFO - 'NO_EM_RESTART': '1', 15:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:40 INFO - 'PWD': '/builds/slave/test', 15:59:40 INFO - 'SHELL': '/bin/bash', 15:59:40 INFO - 'SHLVL': '1', 15:59:40 INFO - 'TERM': 'linux', 15:59:40 INFO - 'TMOUT': '86400', 15:59:40 INFO - 'USER': 'cltbld', 15:59:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:40 INFO - '_': '/tools/buildbot/bin/python'} 15:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:40 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 INFO - Downloading docopt-0.6.1.tar.gz 15:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:42 INFO - Running setup.py install for blobuploader 15:59:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:43 INFO - Running setup.py install for requests 15:59:43 INFO - Running setup.py install for docopt 15:59:43 INFO - Successfully installed blobuploader requests docopt 15:59:43 INFO - Cleaning up... 15:59:43 INFO - Return code: 0 15:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:43 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 15:59:43 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 15:59:43 INFO - Using env: {'DISPLAY': ':0', 15:59:43 INFO - 'HOME': '/home/cltbld', 15:59:43 INFO - 'LANG': 'en_US.UTF-8', 15:59:43 INFO - 'LANGUAGE': 'en_US:en', 15:59:43 INFO - 'LOGNAME': 'cltbld', 15:59:43 INFO - 'MAIL': '/var/mail/cltbld', 15:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:43 INFO - 'MOZ_NO_REMOTE': '1', 15:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:43 INFO - 'NO_EM_RESTART': '1', 15:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:43 INFO - 'PWD': '/builds/slave/test', 15:59:43 INFO - 'SHELL': '/bin/bash', 15:59:43 INFO - 'SHLVL': '1', 15:59:43 INFO - 'TERM': 'linux', 15:59:43 INFO - 'TMOUT': '86400', 15:59:43 INFO - 'USER': 'cltbld', 15:59:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:43 INFO - '_': '/tools/buildbot/bin/python'} 15:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 INFO - Running setup.py (path:/tmp/pip-XBBcQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:43 INFO - Running setup.py (path:/tmp/pip-eLcGjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:43 INFO - Running setup.py (path:/tmp/pip-llfJdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:43 INFO - Running setup.py (path:/tmp/pip-eXjM9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:44 INFO - Running setup.py (path:/tmp/pip-ZQSiz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:44 INFO - Running setup.py (path:/tmp/pip-ordgKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:44 INFO - Running setup.py (path:/tmp/pip-f07DPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:44 INFO - Running setup.py (path:/tmp/pip-y7MZec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:44 INFO - Running setup.py (path:/tmp/pip-HI2yLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Running setup.py (path:/tmp/pip-UgK_QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 INFO - Running setup.py (path:/tmp/pip-cRNpc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 INFO - Running setup.py (path:/tmp/pip-5R4lf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 INFO - Running setup.py (path:/tmp/pip-6OBji_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Running setup.py (path:/tmp/pip-TW6ZCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 INFO - Running setup.py (path:/tmp/pip-DlLNi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:44 INFO - Running setup.py (path:/tmp/pip-jVCeUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:44 INFO - Running setup.py (path:/tmp/pip-A1cxm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:44 INFO - Running setup.py install for manifestparser 15:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Running setup.py install for mozcrash 15:59:45 INFO - Running setup.py install for mozdebug 15:59:45 INFO - Running setup.py install for mozdevice 15:59:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Running setup.py install for mozfile 15:59:45 INFO - Running setup.py install for mozhttpd 15:59:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Running setup.py install for mozinfo 15:59:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Running setup.py install for mozInstall 15:59:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:45 INFO - Running setup.py install for mozleak 15:59:45 INFO - Running setup.py install for mozlog 15:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Running setup.py install for moznetwork 15:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Running setup.py install for mozprocess 15:59:46 INFO - Running setup.py install for mozprofile 15:59:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Running setup.py install for mozrunner 15:59:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Running setup.py install for mozscreenshot 15:59:46 INFO - Running setup.py install for moztest 15:59:46 INFO - Running setup.py install for mozversion 15:59:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:46 INFO - Cleaning up... 15:59:46 INFO - Return code: 0 15:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:46 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:46 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 15:59:46 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 15:59:46 INFO - Using env: {'DISPLAY': ':0', 15:59:46 INFO - 'HOME': '/home/cltbld', 15:59:46 INFO - 'LANG': 'en_US.UTF-8', 15:59:46 INFO - 'LANGUAGE': 'en_US:en', 15:59:46 INFO - 'LOGNAME': 'cltbld', 15:59:46 INFO - 'MAIL': '/var/mail/cltbld', 15:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:46 INFO - 'MOZ_NO_REMOTE': '1', 15:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:46 INFO - 'NO_EM_RESTART': '1', 15:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:46 INFO - 'PWD': '/builds/slave/test', 15:59:46 INFO - 'SHELL': '/bin/bash', 15:59:46 INFO - 'SHLVL': '1', 15:59:46 INFO - 'TERM': 'linux', 15:59:46 INFO - 'TMOUT': '86400', 15:59:46 INFO - 'USER': 'cltbld', 15:59:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:46 INFO - '_': '/tools/buildbot/bin/python'} 15:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:47 INFO - Running setup.py (path:/tmp/pip-mbHHsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:47 INFO - Running setup.py (path:/tmp/pip-VPd3_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:47 INFO - Running setup.py (path:/tmp/pip-dAKrvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:47 INFO - Running setup.py (path:/tmp/pip-DTrvUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:47 INFO - Running setup.py (path:/tmp/pip-ZlFC2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:47 INFO - Running setup.py (path:/tmp/pip-5uWrpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:47 INFO - Running setup.py (path:/tmp/pip-GKjsB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:47 INFO - Running setup.py (path:/tmp/pip-vzKB7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:47 INFO - Running setup.py (path:/tmp/pip-vdOcWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:47 INFO - Running setup.py (path:/tmp/pip-YDZ1dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:47 INFO - Running setup.py (path:/tmp/pip-O3KLjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:47 INFO - Running setup.py (path:/tmp/pip-lvZlMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:47 INFO - Running setup.py (path:/tmp/pip-xSWzS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:47 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)) 15:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:47 INFO - Running setup.py (path:/tmp/pip-WaOgdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:48 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)) 15:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:48 INFO - Running setup.py (path:/tmp/pip-mwRp1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:48 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)) 15:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:48 INFO - Running setup.py (path:/tmp/pip-jbaY5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:48 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)) 15:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:48 INFO - Running setup.py (path:/tmp/pip-HSMMjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:48 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)) 15:59:48 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)) 15:59:48 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)) 15:59:48 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)) 15:59:48 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)) 15:59:48 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)) 15:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:50 INFO - Downloading blessings-1.6.tar.gz 15:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:50 INFO - Installing collected packages: blessings 15:59:50 INFO - Running setup.py install for blessings 15:59:50 INFO - Successfully installed blessings 15:59:50 INFO - Cleaning up... 15:59:50 INFO - Return code: 0 15:59:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:50 INFO - Reading from file tmpfile_stdout 15:59:50 INFO - Current package versions: 15:59:50 INFO - argparse == 1.2.1 15:59:50 INFO - blessings == 1.6 15:59:50 INFO - blobuploader == 1.2.4 15:59:50 INFO - docopt == 0.6.1 15:59:50 INFO - manifestparser == 1.1 15:59:50 INFO - mozInstall == 1.12 15:59:50 INFO - mozcrash == 0.17 15:59:50 INFO - mozdebug == 0.1 15:59:50 INFO - mozdevice == 0.48 15:59:50 INFO - mozfile == 1.2 15:59:50 INFO - mozhttpd == 0.7 15:59:50 INFO - mozinfo == 0.9 15:59:50 INFO - mozleak == 0.1 15:59:50 INFO - mozlog == 3.1 15:59:50 INFO - moznetwork == 0.27 15:59:50 INFO - mozprocess == 0.22 15:59:50 INFO - mozprofile == 0.28 15:59:50 INFO - mozrunner == 6.11 15:59:50 INFO - mozscreenshot == 0.1 15:59:50 INFO - mozsystemmonitor == 0.0 15:59:50 INFO - moztest == 0.7 15:59:50 INFO - mozversion == 1.4 15:59:50 INFO - psutil == 3.1.1 15:59:50 INFO - requests == 1.2.3 15:59:50 INFO - wsgiref == 0.1.2 15:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:50 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 15:59:50 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 15:59:50 INFO - Using env: {'DISPLAY': ':0', 15:59:50 INFO - 'HOME': '/home/cltbld', 15:59:50 INFO - 'LANG': 'en_US.UTF-8', 15:59:50 INFO - 'LANGUAGE': 'en_US:en', 15:59:50 INFO - 'LOGNAME': 'cltbld', 15:59:50 INFO - 'MAIL': '/var/mail/cltbld', 15:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:50 INFO - 'MOZ_NO_REMOTE': '1', 15:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:50 INFO - 'NO_EM_RESTART': '1', 15:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:50 INFO - 'PWD': '/builds/slave/test', 15:59:50 INFO - 'SHELL': '/bin/bash', 15:59:50 INFO - 'SHLVL': '1', 15:59:50 INFO - 'TERM': 'linux', 15:59:50 INFO - 'TMOUT': '86400', 15:59:50 INFO - 'USER': 'cltbld', 15:59:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:50 INFO - '_': '/tools/buildbot/bin/python'} 15:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 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)) 15:59:50 INFO - Cleaning up... 15:59:50 INFO - Return code: 0 15:59:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:50 INFO - Using env: {'DISPLAY': ':0', 15:59:50 INFO - 'HOME': '/home/cltbld', 15:59:50 INFO - 'LANG': 'en_US.UTF-8', 15:59:50 INFO - 'LANGUAGE': 'en_US:en', 15:59:50 INFO - 'LOGNAME': 'cltbld', 15:59:50 INFO - 'MAIL': '/var/mail/cltbld', 15:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:50 INFO - 'MOZ_NO_REMOTE': '1', 15:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:50 INFO - 'NO_EM_RESTART': '1', 15:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:50 INFO - 'PWD': '/builds/slave/test', 15:59:50 INFO - 'SHELL': '/bin/bash', 15:59:50 INFO - 'SHLVL': '1', 15:59:50 INFO - 'TERM': 'linux', 15:59:50 INFO - 'TMOUT': '86400', 15:59:50 INFO - 'USER': 'cltbld', 15:59:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:50 INFO - '_': '/tools/buildbot/bin/python'} 15:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:50 INFO - Downloading/unpacking jsonschema 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:52 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:53 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:53 INFO - warning: no files found matching '*.txt' 15:59:53 INFO - no previously-included directories found matching 'build' 15:59:53 INFO - no previously-included directories found matching 'dist' 15:59:53 INFO - no previously-included directories found matching '.git*' 15:59:53 INFO - Installing collected packages: jsonschema, functools32 15:59:53 INFO - Running setup.py install for functools32 15:59:53 INFO - warning: no files found matching '*.txt' 15:59:53 INFO - no previously-included directories found matching 'build' 15:59:53 INFO - no previously-included directories found matching 'dist' 15:59:53 INFO - no previously-included directories found matching '.git*' 15:59:53 INFO - Successfully installed jsonschema functools32 15:59:53 INFO - Cleaning up... 15:59:53 INFO - Return code: 0 15:59:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:53 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 0x7f7241b5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', '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 15:59:53 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 15:59:53 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 15:59:53 INFO - Using env: {'DISPLAY': ':0', 15:59:53 INFO - 'HOME': '/home/cltbld', 15:59:53 INFO - 'LANG': 'en_US.UTF-8', 15:59:53 INFO - 'LANGUAGE': 'en_US:en', 15:59:53 INFO - 'LOGNAME': 'cltbld', 15:59:53 INFO - 'MAIL': '/var/mail/cltbld', 15:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:53 INFO - 'MOZ_NO_REMOTE': '1', 15:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:53 INFO - 'NO_EM_RESTART': '1', 15:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:53 INFO - 'PWD': '/builds/slave/test', 15:59:53 INFO - 'SHELL': '/bin/bash', 15:59:53 INFO - 'SHLVL': '1', 15:59:53 INFO - 'TERM': 'linux', 15:59:53 INFO - 'TMOUT': '86400', 15:59:53 INFO - 'USER': 'cltbld', 15:59:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 15:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:53 INFO - '_': '/tools/buildbot/bin/python'} 15:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:53 INFO - Downloading/unpacking flake8 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:56 INFO - no previously-included directories found matching 'docs/_build' 15:59:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:56 INFO - Running setup.py install for pep8 15:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:56 INFO - no previously-included directories found matching 'docs/_build' 15:59:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:56 INFO - Cleaning up... 15:59:56 INFO - Return code: 0 15:59:56 INFO - Running post-action listener: _resource_record_post_action 15:59:56 INFO - Running post-action listener: _start_resource_monitoring 15:59:56 INFO - Starting resource monitoring. 15:59:56 INFO - ##### 15:59:56 INFO - ##### Running install step. 15:59:56 INFO - ##### 15:59:56 INFO - Running pre-action listener: _resource_record_pre_action 15:59:56 INFO - Running main action method: install 15:59:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:56 INFO - Reading from file tmpfile_stdout 15:59:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:56 INFO - Reading from file tmpfile_stdout 15:59:56 INFO - Output received: 15:59:56 INFO - Usage: mozinstall [options] installer 15:59:56 INFO - Options: 15:59:56 INFO - -h, --help show this help message and exit 15:59:56 INFO - -d DEST, --destination=DEST 15:59:56 INFO - Directory to install application into. [default: 15:59:56 INFO - "/builds/slave/test"] 15:59:56 INFO - --app=APP Application being installed. [default: firefox] 15:59:56 INFO - mkdir: /builds/slave/test/build/application 15:59:56 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'] 15:59:56 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 16:00:12 INFO - Reading from file tmpfile_stdout 16:00:12 INFO - Output received: 16:00:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:00:12 INFO - Running post-action listener: _resource_record_post_action 16:00:12 INFO - ##### 16:00:12 INFO - ##### Running run-tests step. 16:00:12 INFO - ##### 16:00:12 INFO - Running pre-action listener: _resource_record_pre_action 16:00:12 INFO - Running main action method: run_tests 16:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:12 INFO - Python 2.7.3 16:00:12 INFO - Return code: 0 16:00:12 INFO - grabbing minidump binary from tooltool 16:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:12 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 0x29d2410>, '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 0x29d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:12 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 16:00:12 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 16:00:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:12 INFO - Return code: 0 16:00:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:00:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:00:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:00:13 INFO - Return code: 0 16:00:13 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/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:00:13 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/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:00:13 INFO - Using env: {'DISPLAY': ':0', 16:00:13 INFO - 'HOME': '/home/cltbld', 16:00:13 INFO - 'LANG': 'en_US.UTF-8', 16:00:13 INFO - 'LANGUAGE': 'en_US:en', 16:00:13 INFO - 'LOGNAME': 'cltbld', 16:00:13 INFO - 'MAIL': '/var/mail/cltbld', 16:00:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:13 INFO - 'MOZ_NO_REMOTE': '1', 16:00:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:13 INFO - 'NO_EM_RESTART': '1', 16:00:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:13 INFO - 'PWD': '/builds/slave/test', 16:00:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:13 INFO - 'SHELL': '/bin/bash', 16:00:13 INFO - 'SHLVL': '1', 16:00:13 INFO - 'TERM': 'linux', 16:00:13 INFO - 'TMOUT': '86400', 16:00:13 INFO - 'USER': 'cltbld', 16:00:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727', 16:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:13 INFO - '_': '/tools/buildbot/bin/python'} 16:00:13 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/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:00:13 INFO - mozversion application_buildid: 20160412151348 16:00:13 INFO - mozversion application_changeset: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 16:00:13 INFO - mozversion application_display_name: Nightly 16:00:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:13 INFO - mozversion application_name: Firefox 16:00:13 INFO - mozversion application_remotingname: firefox 16:00:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:00:13 INFO - mozversion application_vendor: Mozilla 16:00:13 INFO - mozversion application_version: 48.0a1 16:00:13 INFO - mozversion platform_buildid: 20160412151348 16:00:13 INFO - mozversion platform_changeset: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 16:00:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:00:13 INFO - mozversion platform_version: 48.0a1 16:00:13 INFO - using testdate: 1460502013 16:00:13 INFO - actual date: 1460502013 16:00:13 INFO - starting webserver on 'localhost:39291' 16:00:13 INFO - SUITE-START | Running 2 tests 16:00:13 INFO - TEST-START | dromaeo_css 16:00:13 INFO - operating with platform_type : linux_ 16:00:13 INFO - Initialising browser for dromaeo_css test... 16:00:13 INFO - TEST-INFO | started process 6510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMcTv6/profile http://localhost:39291/getInfo.html) 16:00:18 INFO - PROCESS | 6510 | __metrics Screen width/height:1600/1200 16:00:18 INFO - PROCESS | 6510 | colorDepth:24 16:00:18 INFO - PROCESS | 6510 | Browser inner width/height: 1024/697 16:00:18 INFO - PROCESS | 6510 | __metrics 16:00:20 ERROR - PROCESS | 6510 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:00:21 INFO - TEST-INFO | 6510: exit 0 16:00:21 INFO - Browser initialized. 16:00:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:21 INFO - TEST-INFO | started process 6590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMcTv6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:33 INFO - PROCESS | 6590 | RSS: Main: 154861568 16:00:33 INFO - PROCESS | 6590 | 16:01:24 INFO - PROCESS | 6590 | 1460502084669 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] 16:03:36 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39291/tests/dromaeo/cssquery-ext.html) 16:03:37 INFO - PROCESS | 6590 | RSS: Main: 269905920 16:03:37 INFO - PROCESS | 6590 | 16:06:40 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-ext.html (next: http://localhost:39291/tests/dromaeo/cssquery-jquery.html) 16:06:40 INFO - PROCESS | 6590 | RSS: Main: 240787456 16:06:40 INFO - PROCESS | 6590 | 16:09:42 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39291/tests/dromaeo/cssquery-mootools.html) 16:09:43 INFO - PROCESS | 6590 | RSS: Main: 229187584 16:09:43 INFO - PROCESS | 6590 | 16:12:45 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39291/tests/dromaeo/cssquery-prototype.html) 16:12:46 INFO - PROCESS | 6590 | RSS: Main: 215289856 16:12:46 INFO - PROCESS | 6590 | 16:15:48 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39291/tests/dromaeo/cssquery-yui.html) 16:15:49 INFO - PROCESS | 6590 | RSS: Main: 211111936 16:15:49 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-yui.html (next: http://localhost:39291/tests/dromaeo/cssquery-dojo.html) 16:18:52 INFO - PROCESS | 6590 | RSS: Main: 268357632 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | __start_tp_report 16:18:52 INFO - PROCESS | 6590 | _x_x_mozilla_page_load 16:18:52 INFO - PROCESS | 6590 | _x_x_mozilla_page_load_details 16:18:52 INFO - PROCESS | 6590 | |i|pagename|runs| 16:18:52 INFO - PROCESS | 6590 | |0;dojo.html;2641.5245255853943;2703.9459210815785;2712.796540259481;2721.5101281769275;2741.3694850184456;4632.976835115828;4703.270992996083;4731.077439899217;4741.431028276607;4759.190937540622;4638.582527572517;4676.39206903103;4739.549742774431;4748.097861406331;4761.47623761386;4294.699371044028;4297.205017071836;4336.457942757155;4361.323994780814;4457.219986502365;4388.97805510972;4416.84541041062;4429.579189976947;4462.308342206947;4474.530174331697;4252.574742525722;4283.0363168287195;4285.078708077778;4359.411479450266;4382.189294980423;4330;4356.172327257811;4363.105563359503;4373.737575745466;4410.0077482566485;4341.782910854445;4345.717528360678;4351.912961740779;4372.366006928977;4383.671224658164;4482.753448560328;4547.7271363717955;4620.884477888046;4628.39830821991;4640.65195110368;5096.159133742928;5102.668326558762;5119.872003199913;5123.2315152727015;5176.482351764794;5133.563647090002;5144.4083930348115;5150.639455238135;5151.304573882516;5160.432352441228;4637.234856248715;4740.407449068866;4788.353572267769;4817.566419022305;4826.227803551415;5226.529612334908;5250.343707036621;5253.711045892436;5253.737313134328;5259.921101183485;4851.199552073868;5000.224965130411;5001.474845141281;5003.849884503471;5052.393712754493;5070.569001634903;5089.236614507853;5129.8717532062;5130.538251557377;5138.075146473596;4999.10016197088;5000.974995125001;5006.749662516932;5014.724190169502;5057.165567681292;4876.146674332049;4993.975030124826;5001.72490513018;5004.199328107558;5009.814841638886;4245.426867372927;4245.893852653647;4251.59609837065;4252.55348188442;4311.159323931866;3702.8889133326043;3709.647583479565;3744.419614959631;3752.3058234226755;3782.7541209821825;4368.366586844953;4377.212101821639;4380.123975204971;4381.277089280296;4421.226285400042;4968.8509344719;5066.138756411419;5069.645124841226;5103.642745007888;5156.587473002151;4403.559644035571;4406.515283318832;4413.58070983256;4427.380166776654;4447.933281000787;4488.663350248745;4517.909641807146;4525.298578720303;4531.229690952546;4578.88552786183;4688.859334219979;4783.354247176587;4785.521447855187;4864.173090574682;4876.926846097383;5027;5029.27075574047;5041.773120209526;5053.67151135175;5101.642884998015;4756.096341695067;4757.690750101232;4762.880927976828;4765.070811191785;4807.807687692593;4915.361003069578;4995.5254250847565;5035.29505869186;5048.217526283432;5069.923951140662;5010.599152067899;5024.070546948826;5030.119729047476;5042.067217564762;5083.796648134034;4825.10735513931;4861.4895435978715;4867.829625963074;4868.075065737498;4912.803487860446;4900.730459824744;4911.459739428588;4956.355673762532;4964.379452568429;4993.4756850530175;4830.2996065571;4860.465348811557;4888.853334399973;4923.359963204761;4940.407151141886;4851.345068415719;4965.602751779777;4987.0524600325825;4994.675346102492;5045.596352291881;4780.95219047805;4821.252705830602;4848.515148485123;4892.951070489249;4897.58370538494 16:18:52 INFO - PROCESS | 6590 | |1;ext.html;565.7454145634465;600.3426248258157;603.167628672432;616.9938300616992;620.4540004795779;33256.33487330252;34487.48268775964;34675;34682;34719.82640086799;35316.293674126566;35901.2819743605;35910.46134307988;35918;35945.28109437809;7355.705771769123;7588.16530181681;7776.844463110734;7783.260590243918;9408.247340212767;9524.476153811538;9629.422234665943;9645.373050751714;9665.565049572751;9669.17811985982;9699.660511882086;9793.167580755644;9797.559109840075;9802.754931126708;9814.46020468874;7518.135414427356;7808.063032436087;7808.297253247179;9659.323847330654;9683.757906052406;9614.663486778;9771.511424428822;9775.169110625606;9779.119879210904;9781.434970404773;33169;33778.6622133778;33787.324253514795;33867.830660846535;33871.15322116942;3086.2284428892776;3127.8123312601315;3202.2634793997513;3354.6142193647797;3814;28294.434111317863;28542.14373568796;28925;29056.8547157265;29584.70415295841;3426.2462258303135;3429.537012503305;3474.722022238215;3505.404081306159;3541.7166626669805;208401;209349.9532502343;209690;209720;209942;31706.207344816565;50190.49809501931;50203.497965020615;50742.492575073775;50815.74592127016;31260.218494537363;31354.372912542076;31395.84302078475;31419.915410996426;31434.68565314363;12200.084993625514;12304.323262220663;12314.384280785926;12322.322272274932;12337.444814983348;9696.466694331739;10605.84091238632;10862.891371086345;10917.727056823484;10920.836187457195;7796.4932279401655;7818.804529886685;7844.4901081429525;7915.881261781078;7916.604169791487;3172.6510083890753;3178.300773829754;3216.1477208539754;3218.3241519281214;3248.415285248631;896.462122726359;946.9763255918657;951.8286708392417;1005.6329439754437;1062.4634559547533;26655.600165997526;28004.859975700398;28027.823240589376;28212;28362.71637283642;968.2496065549255;1020.1481762728205;1069.2034434346463;1073.1951036722458;1090.929089609173;14715.411383544539;14973.925130374497;14979.525427776773;15069.401842403055;15161.545153645407;135547;137336;137639;303058;304845;46391.768041160256;47294.29058564124;47314.290285645744;47351;47392.28911566329;1074.4896174317137;1177.0877569883237;1238.0900038471716;1262.955796547135;1271.5168236070233;26009;27269.59095613607;27611.368274351218;27665.72334276712;27871.303217419725;37766.24467510689;37881.62118378891;38220.235595287384;38253.218347706534;38309.808450958684;214984;215510;215519;215695;216163;22187.445313867283;24472.87763561171;25082.247532574052;25092.247232583053;25095.121670741435;38264;38542.80728596339;38843.80578097091;39445.80277098596;39447.408288876264;33548;33584.83207583946;33657.663423365455;34031.48952765661;34416.65583344134;32946;33337.666623333454;33368;33540.49689254712;33549.329013419105;33315.83342083274;33611.99164025083;33697.326053479286;34076.31847362989;34132;29682.55476167816;31216.738572034035;35008.29983400369;35123.47314790229;35141.47287790736;24265.39336516601;24686.876565617058;24781.25656230316;25148.74851251464;25183.74816251814 16:18:52 INFO - PROCESS | 6590 | |2;jquery.html;347.7617831785226;358.7058611938212;359.6673077403401;363.26076434455877;371.58197028343113;15541.300641471147;15636.296366663513;16556.75164872528;16648;16661.91669041656;16060.437884674038;16734.497965061037;16859.747103793452;16906.408275710353;16906.830931690678;5021;5264.684118952875;5311.176767601028;5315.521603055724;5322.20166974953;3677.3196958562617;3882.1265215326466;5215.061288967984;5596.076647353182;5943.70281485924;5875.941240587604;5887.8233652990475;5888.499477544414;5900.852478688024;5912.17229587858;5645.463680950324;6104.114903338991;6104.633721976696;6109.114178444145;6110.511159107261;3348.2131699050706;4800.4719480857075;5105.157648987913;5118.206677964921;5340.065488539529;17928;18817.717734233862;18845.434636960912;18974.71537926932;18994.24023039077;1923.4998900285887;1925.711143328512;1948.9512762180916;1971.5958228563254;2052.95894082119;11881;12155.696107597292;12283.631491055283;12395.194312369667;12589.811152832715;1712.8544073753746;1742.6079132195282;1756.6223261998605;1844.2807305151002;1847.5288801355568;63088.684556577384;64010.67994659997;64200;65155.674221628586;71647.64176179138;14626.49089767739;15159.772603410958;15168.165750883807;15239.304151403692;15521;29327;29479.705202948124;29719;29726.851365743034;29770.255743606584;8513.106123856905;8737.776711260429;8797.38418310725;8845.955770221108;8890.688825891191;7029.22678505364;7133.643317834191;7234.855302893912;7259.818504537323;7282.635868206568;8234.258916697527;8300.89626125327;8323.791905202419;8347.290480309242;8384.958075209584;2817.3801763611973;3277.3609146216736;3356.8992930212135;3400.803244949739;3430.776999495025;785.2618538573722;869.6260607938647;899.3974037394961;957.0333962697725;966.1497881863914;14953.626159346104;15007.624809379853;16615.3353865844;16673;16882.74675879863;847.877057826624;854.3080105114752;858.5578427110044;881.5504092912661;914.6707185413246;8962.82074358509;9295.58169882357;9343.579538920765;9420.481873496887;9491.620335186653;377729;381220;383817;387972;389278;76146.61926690442;76220.23779762132;76372;76884.61557692288;77612.17908656874;907.160876189522;919.4758987377131;921.1019256225261;927.6567669962158;931.3247895276006;14472.131672099707;14578.232474982082;14578.416863325348;14609.707805844037;14941.178235197169;31537.634677399747;32643.836780815946;32713.836430818646;32869.50695739518;33315.83342083371;44488.33267501055;45570.772146139054;45575;45577.088458229984;45634.54365456436;7284.526505777108;7307.196208417176;7344.30229128232;7382.077240344957;7451.2176221495965;6231.5637905348;8064.798380040546;10037.648682296085;10381.377117372982;10612.946935265274;9018.09819018093;9134.954325228331;9145.588448519966;9248.861267081134;9616.507496659793;8860;8954.731358059269;8977.192052715287;9164.358494905558;9274.397164184307;5364.785408583613;7262.6731797068205;9130.634774608941;9354.362986477476;9626;6653.403183235891;6722.9663851680425;6767.39093481589;7136.000959865727;7243.261617211937;7886.487378320391;9436.811263774549;9493.325934220522;9836.803263934538;10402.687919362432 16:18:52 INFO - PROCESS | 6590 | |3;mootools.html;1283.178765590022;1421.644588852787;1429.0354011042548;1591.734571016042;1788.7406326082726;6721.26066132725;7590.468667193299;7789.92210077899;7800.921990780083;7808.8047798805055;7454.515456495324;7454.88817667734;7537.24627537246;7555.848883022336;7582.128055273645;1937.7868434472198;2220.145244081032;2242.955140897181;2247.0000849621924;2332.9883350583223;2279.225063478417;2298.9885050574726;2300.7584203658625;2303.562323158603;2305.227748704186;2209;2264.230161745006;2265.558216147852;2267.557826223887;2268.2061278552455;1897.8671492995427;2180.487585417418;2262.242148880127;2265.7394399644086;2266.8413211075067;2228.097620463715;2228.7882651148116;2235.2176738141684;2236.8657880527057;2275.6472746724285;7604.4296677748835;7610.8477830443635;7664.425168112358;7680.6159692015735;7699.769006929801;4414.337849322627;4582.083583283356;4607.723536587815;4615.930761038587;4678.532146785295;2994.9634248710868;3018.0794857568435;3033.1507177990197;3069.723724864773;3073.4160509503345;951.7691243328694;957.8275910336137;970.3013830042358;979.3536266064434;987.2200961240611;10810.675679729542;10829.945850270777;10861.5112319945;10874.18443616732;10890.61882834105;4215.515215750167;4339.435873336446;4367.8861890217795;4379.540148284448;4524.47968483622;8367.832643347221;8394.580270986426;8405.621747021398;8442.071372149181;8463.788405289793;4040.2727509048063;4525.140223357552;4564.475085365159;4568;4578;4069.3895915612893;4209.831606735757;4215.156968606291;4222.831086756557;4247.97876010618;3509.3332266869215;3543.1496440854007;3594.155373487228;3617.8733744318824;3669.7614655047337;1046.9528871200814;1087.331291255872;1091.2797553614575;1093.8031154392127;1111.7387413957713;1235.1600911380167;1235.6910772306924;1256.654420034498;1258.7167887225485;1277.5975567696146;7374.151972523228;7447.88828167578;7500.212477689873;7519.060117485315;7532.698692052366;457.72307753809133;467.75910406140866;468.09890959902054;468.2461237407771;472.15248628711544;5651.943480565142;5870.5890587659305;5912.054071348563;5918.674472904032;5924.555658325557;9077.183053525214;9913.405195688138;9920.255980801325;9937.7018689438;10067.144292735053;9494.477803720862;9730.318877678494;9836.754081147885;9859.161971232383;9865.556049977768;7381.077365329334;7418.666160022812;7459.142198647117;7522.623868806538;7567.129780075252;7144.535605185646;7323.780286591411;7326.120865496175;7439.070116235471;7449.5902725350625;9001.684941027033;9050.049744776703;9090;9168;9209.86185207209;8894.33292503052;9094.681686140953;9268.212201962908;9277.350585458953;9293.907060929574;6231.532635052298;6416.807495775134;6680.766173183915;7020.929790702027;7150;7087.893681594884;7112.35988761014;7149.034880291302;7166.068411106523;7190.496665233383;6457.644829534421;6725.529212955242;6759.256481787098;6847.417969472651;6885.208201056943;6618.139641846529;6618.63597502142;6623.172103487064;6684.498662600227;6734.797956061326;6872.965635171792;7050.753223637148;7083.858322833411;7146.071010768567;7162.068931038932;6376.330485299162;6427.871442571216;6436.066770318184;6511.3163117871945;6518.837029074311;6642.335766423513;6692.196936367667;6696.229933557508;6712.899306510309;6718.361755633207 16:18:52 INFO - PROCESS | 6590 | |4;prototype.html;305.8486049405545;309.52178883624805;310.3947302759619;311.826936050492;317.4143704864524;5056.646034777567;5108.540231379176;5131.102057139995;5140.922886156711;5147.124988751912;5048.924266136001;5070.366204224472;5075.593952483801;5078.1874900016;5084.898302033957;3774.5470543534675;3850;3897.376419772837;3985.880423587297;3992.1017771001584;3974.3641017437217;3977.2840888640035;3977.6221258980495;3989.321815291393;3989.6209860063245;3947.4868267125235;3949.881503554898;3955.3078211312904;3963.742356746802;3965.781881996489;3739.906502337436;3810.961890381116;3970.7816070116132;3981.4824072870633;3986.40203969404;3501.8949431517094;3517.595476520182;3518.577770667511;3523.3834079036064;3524.488949102366;4893.388326459192;4905.117078925792;4909.926351104737;4913.525942217356;4927.728974906378;4440.467143942716;4543.273076307775;4549.363089167519;4553.863384098482;4554.203014472454;5257.5005374489365;5291.656042357235;5297.7880884764945;5322.547583455411;5332.866678333034;3813.046738315421;3817.828197731109;3822.847086116552;3824.8852534424013;3825.5791862895057;5381.112116500773;5556;5556.083246264361;5566.2207290979295;5581.944180558224;3920.2355540669864;3942.802859857053;3945.0926286954164;3946.7631942082994;3949.170674158459;3995.9800200998807;3998.580149084304;4003;4004.1391100913443;4010.2981978153707;4314.352847072902;4459.687821852439;4511.932321015187;4534.6372290216705;4546.29532422475;5312.123499622597;5335.838985210996;5336.546393556514;5336.893262134813;5342.305500284938;1369.4385302026121;1397.3362652739868;1397.9231142287272;1400.2858542143376;1400.8319001719656;891.1355984694835;922.1792604581927;956.7512446763892;970.8689326940914;975.1321324021626;4576.656750743708;4732.5977291929885;4743.075100355467;4783.1390349737385;4824.782884770124;5547.583931205176;5553.611247212737;5571.693556854412;5579.972100139474;5581.302337207849;4511.684182107221;4748.406449193851;4749.335093086971;4774.7851346688785;4780.49804770501;2914.9708502915123;2965.154930844742;2970.2722832906074;2972.673005969342;2985.283531952359;5241.659292145999;5243.292155559027;5251.553617942442;5257.263983042377;5265.921011184835;5428.348598168245;5703.258576385043;5714.714264286852;5746.2529871116485;5752.223449834219;5260.237265596544;5265.6050796189675;5270.657407268515;5279;5288.81489147878;5537.065355361665;5560.972195138998;5564.666120032811;5610;5620.803271885465;5224.05966925957;5412.269343638558;5415.810446634349;5434.429384914527;5440.591955603267;5206.895862082662;5213.895722085613;5217.295665085317;5227.817026404057;5230.607704422259;3784.8296826642318;3824.7322687411615;3830.084957521239;3834.7123965702126;3856.132370216791;5350.197470379474;5545.584081193846;5555.50000499957;5560.610757246954;5572.164175373727;5348.5988550858065;5359.892802144013;5381.381141168659;5389;5401.135818269058;5115.488451154854;5385.838424847261;5394.730263486888;5399.676019438846;5405.297311349499;5289.788408463618;5329.467053294639;5332.386775520865;5332.6000549958135;5347.1979203119845;5065.29085927963;5220.765065571983;5368.7047212403695;5369.785208591613;5406.459354064562;5255.448177941414;5290.365156181129;5304.522592966651;5307.495787900143;5313.840584782462 16:18:52 INFO - PROCESS | 6590 | |5;yui.html;699.6047233313176;723.4284914917216;757.6439073635389;764.2739397572304;766.2911806578913;14048.227347495884;14729.705405891877;14746.336414861331;14758.557243282692;14779.26103694815;13589.592312230625;13681.452741890338;13684.52104176354;13752;13811.447542098304;649.2014821769227;810.9797255068612;814.0556953933409;820.4666966471782;822.2558584481025;841.6128580852784;847.1020718038868;847.525385783963;847.7117779954814;847.9067302596709;867.1501928110424;873.9519326437044;877.1009715042069;877.5261358866204;877.7893305606673;678;845.8477474054667;862.7282406042108;869.7999460124175;871.0897112517434;633.2306247908813;635.5995722694673;638.3201889987196;638.6423602782456;639.859230969186;13395.732085358239;13405.932970335087;13440.260785656785;13441.462341506329;13467.12463689857;11911.225770324987;12206.633800985985;12275.140740148194;12461.75076498474;12472.875271247261;10236.43699596522;10275.332103413255;10352.4306163161;10556.261061725681;10621.25651204416;3342.3148254607745;3353.6311005789344;3396.100033491127;3399.5750531183603;3402.4556071028765;46472.070558588974;46777.064458710636;47133;47735.283970740464;48092.27861582079;9655.468949207721;9730.854037189449;9798.804023919623;9831.950840245752;9836.60653573849;17164.39924602633;17196.656066878593;17259.827401726074;17349;17351.56621084483;6872.175338959357;6890.345417185359;6914.688839002257;6956.65216739161;7114.110736157981;3634.745567810228;3732.141607430306;3840.423936409505;3850.441685955521;3910.7458015228917;2826.1804076817903;2908.6509618845453;2918.3287843796047;2922.0357282097284;2926.078285340111;508.47118996244234;511.2127323921194;520.4795204795205;521.6817741177879;537.0842713174029;519.7037688517509;563.5688698145922;631.7514713551421;657.9309172536911;671.5433505216499;7736.342410895025;7836.490628109154;7916.960415197887;8056.597170141469;8148.837023259502;505.48945564979635;577.151587166864;625.8935980883169;627.9937200628027;655.1090516897016;3716.962830371716;3811.1996480739354;3855.2867719471988;3919.451276821247;3957.920841583152;49079.754601227476;49887.75056124696;49960.750196249515;50183;50357.244641330406;43710.56289437129;44455.33317000248;44779.328310075376;45104.09791804211;46139.30791038137;35604.28791424157;37879.431808522895;38897;39194;41813.37279940803;7463.701451941862;7863.803404914923;7948.046234451903;8118.9188108120525;8219.753407397788;27042.459150817267;27140.864295678395;27209.455810883275;28006.85996570004;28394.006209782558;34066.65933340635;34069;34106.48840267348;34973.300533988666;35157;9573.138417542455;10207.336523125972;10332.276740628084;10400.531976061247;10683.542785159301;10701.518431670438;10886.40124793144;11134.944325278646;11391.373474458984;11631.47658355359;11358.716032099264;11655.592054278399;11773.76452470963;12056.457459414523;12117.75764484723;11381.317120972768;11585.88414115848;11745.412729363668;11941.104417168921;12017.63947081589;10081.344712593658;10301.124404425707;10323.48382580883;10332.638357657446;10641.095506882002;8863.468191908249;9024.59389327495;9136.451812891248;9155.450672959643;9349.439033658002;9476.715698529055;9555.283353748358;9610.279229057709;9856.556454959687;9934.354266972623 16:18:52 INFO - PROCESS | 6590 | __end_tp_report 16:18:52 INFO - PROCESS | 6590 | __start_cc_report 16:18:52 INFO - PROCESS | 6590 | _x_x_mozilla_cycle_collect,1058 16:18:52 INFO - PROCESS | 6590 | __end_cc_report 16:18:52 INFO - PROCESS | 6590 | __startTimestamp1460503132678__endTimestamp 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | ------- Summary: start ------- 16:18:52 INFO - PROCESS | 6590 | Number of tests: 6 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#0] dojo.html Cycles:165 Average:4681.87 Median:4817.57 stddev:486.26 (10.1%) stddev-sans-first:460.65 16:18:52 INFO - PROCESS | 6590 | Values: 2641.5 2703.9 2712.8 2721.5 2741.4 4633.0 4703.3 4731.1 4741.4 4759.2 4638.6 4676.4 4739.5 4748.1 4761.5 4294.7 4297.2 4336.5 4361.3 4457.2 4389.0 4416.8 4429.6 4462.3 4474.5 4252.6 4283.0 4285.1 4359.4 4382.2 4330.0 4356.2 4363.1 4373.7 4410.0 4341.8 4345.7 4351.9 4372.4 4383.7 4482.8 4547.7 4620.9 4628.4 4640.7 5096.2 5102.7 5119.9 5123.2 5176.5 5133.6 5144.4 5150.6 5151.3 5160.4 4637.2 4740.4 4788.4 4817.6 4826.2 5226.5 5250.3 5253.7 5253.7 5259.9 4851.2 5000.2 5001.5 5003.8 5052.4 5070.6 5089.2 5129.9 5130.5 5138.1 4999.1 5001.0 5006.7 5014.7 5057.2 4876.1 4994.0 5001.7 5004.2 5009.8 4245.4 4245.9 4251.6 4252.6 4311.2 3702.9 3709.6 3744.4 3752.3 3782.8 4368.4 4377.2 4380.1 4381.3 4421.2 4968.9 5066.1 5069.6 5103.6 5156.6 4403.6 4406.5 4413.6 4427.4 4447.9 4488.7 4517.9 4525.3 4531.2 4578.9 4688.9 4783.4 4785.5 4864.2 4876.9 5027.0 5029.3 5041.8 5053.7 5101.6 4756.1 4757.7 4762.9 4765.1 4807.8 4915.4 4995.5 5035.3 5048.2 5069.9 5010.6 5024.1 5030.1 5042.1 5083.8 4825.1 4861.5 4867.8 4868.1 4912.8 4900.7 4911.5 4956.4 4964.4 4993.5 4830.3 4860.5 4888.9 4923.4 4940.4 4851.3 4965.6 4987.1 4994.7 5045.6 4781.0 4821.3 4848.5 4893.0 4897.6 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#1] ext.html Cycles:180 Average:36316.35 Median:33567.08 stddev:55966.53 (166.7%) stddev-sans-first:56059.16 16:18:52 INFO - PROCESS | 6590 | Values: 565.7 600.3 603.2 617.0 620.5 33256.3 34487.5 34675.0 34682.0 34719.8 35316.3 35901.3 35910.5 35918.0 35945.3 7355.7 7588.2 7776.8 7783.3 9408.2 9524.5 9629.4 9645.4 9665.6 9669.2 9699.7 9793.2 9797.6 9802.8 9814.5 7518.1 7808.1 7808.3 9659.3 9683.8 9614.7 9771.5 9775.2 9779.1 9781.4 33169.0 33778.7 33787.3 33867.8 33871.2 3086.2 3127.8 3202.3 3354.6 3814.0 28294.4 28542.1 28925.0 29056.9 29584.7 3426.2 3429.5 3474.7 3505.4 3541.7 208401.0 209350.0 209690.0 209720.0 209942.0 31706.2 50190.5 50203.5 50742.5 50815.7 31260.2 31354.4 31395.8 31419.9 31434.7 12200.1 12304.3 12314.4 12322.3 12337.4 9696.5 10605.8 10862.9 10917.7 10920.8 7796.5 7818.8 7844.5 7915.9 7916.6 3172.7 3178.3 3216.1 3218.3 3248.4 896.5 947.0 951.8 1005.6 1062.5 26655.6 28004.9 28027.8 28212.0 28362.7 968.2 1020.1 1069.2 1073.2 1090.9 14715.4 14973.9 14979.5 15069.4 15161.5 135547.0 137336.0 137639.0 303058.0 304845.0 46391.8 47294.3 47314.3 47351.0 47392.3 1074.5 1177.1 1238.1 1263.0 1271.5 26009.0 27269.6 27611.4 27665.7 27871.3 37766.2 37881.6 38220.2 38253.2 38309.8 214984.0 215510.0 215519.0 215695.0 216163.0 22187.4 24472.9 25082.2 25092.2 25095.1 38264.0 38542.8 38843.8 39445.8 39447.4 33548.0 33584.8 33657.7 34031.5 34416.7 32946.0 33337.7 33368.0 33540.5 33549.3 33315.8 33612.0 33697.3 34076.3 34132.0 29682.6 31216.7 35008.3 35123.5 35141.5 24265.4 24686.9 24781.3 25148.7 25183.7 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#2] jquery.html Cycles:180 Average:24252.22 Median:5331.13 stddev:63245.24 (1186.3%) stddev-sans-first:63397.19 16:18:52 INFO - PROCESS | 6590 | Values: 347.8 358.7 359.7 363.3 371.6 15541.3 15636.3 16556.8 16648.0 16661.9 16060.4 16734.5 16859.7 16906.4 16906.8 5021.0 5264.7 5311.2 5315.5 5322.2 3677.3 3882.1 5215.1 5596.1 5943.7 5875.9 5887.8 5888.5 5900.9 5912.2 5645.5 6104.1 6104.6 6109.1 6110.5 3348.2 4800.5 5105.2 5118.2 5340.1 17928.0 18817.7 18845.4 18974.7 18994.2 1923.5 1925.7 1949.0 1971.6 2053.0 11881.0 12155.7 12283.6 12395.2 12589.8 1712.9 1742.6 1756.6 1844.3 1847.5 63088.7 64010.7 64200.0 65155.7 71647.6 14626.5 15159.8 15168.2 15239.3 15521.0 29327.0 29479.7 29719.0 29726.9 29770.3 8513.1 8737.8 8797.4 8846.0 8890.7 7029.2 7133.6 7234.9 7259.8 7282.6 8234.3 8300.9 8323.8 8347.3 8385.0 2817.4 3277.4 3356.9 3400.8 3430.8 785.3 869.6 899.4 957.0 966.1 14953.6 15007.6 16615.3 16673.0 16882.7 847.9 854.3 858.6 881.6 914.7 8962.8 9295.6 9343.6 9420.5 9491.6 377729.0 381220.0 383817.0 387972.0 389278.0 76146.6 76220.2 76372.0 76884.6 77612.2 907.2 919.5 921.1 927.7 931.3 14472.1 14578.2 14578.4 14609.7 14941.2 31537.6 32643.8 32713.8 32869.5 33315.8 44488.3 45570.8 45575.0 45577.1 45634.5 7284.5 7307.2 7344.3 7382.1 7451.2 6231.6 8064.8 10037.6 10381.4 10612.9 9018.1 9135.0 9145.6 9248.9 9616.5 8860.0 8954.7 8977.2 9164.4 9274.4 5364.8 7262.7 9130.6 9354.4 9626.0 6653.4 6723.0 6767.4 7136.0 7243.3 7886.5 9436.8 9493.3 9836.8 10402.7 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#3] mootools.html Cycles:180 Average:5445.22 Median:6446.86 stddev:2913.78 (45.2%) stddev-sans-first:2905.16 16:18:52 INFO - PROCESS | 6590 | Values: 1283.2 1421.6 1429.0 1591.7 1788.7 6721.3 7590.5 7789.9 7800.9 7808.8 7454.5 7454.9 7537.2 7555.8 7582.1 1937.8 2220.1 2243.0 2247.0 2333.0 2279.2 2299.0 2300.8 2303.6 2305.2 2209.0 2264.2 2265.6 2267.6 2268.2 1897.9 2180.5 2262.2 2265.7 2266.8 2228.1 2228.8 2235.2 2236.9 2275.6 7604.4 7610.8 7664.4 7680.6 7699.8 4414.3 4582.1 4607.7 4615.9 4678.5 2995.0 3018.1 3033.2 3069.7 3073.4 951.8 957.8 970.3 979.4 987.2 10810.7 10829.9 10861.5 10874.2 10890.6 4215.5 4339.4 4367.9 4379.5 4524.5 8367.8 8394.6 8405.6 8442.1 8463.8 4040.3 4525.1 4564.5 4568.0 4578.0 4069.4 4209.8 4215.2 4222.8 4248.0 3509.3 3543.1 3594.2 3617.9 3669.8 1047.0 1087.3 1091.3 1093.8 1111.7 1235.2 1235.7 1256.7 1258.7 1277.6 7374.2 7447.9 7500.2 7519.1 7532.7 457.7 467.8 468.1 468.2 472.2 5651.9 5870.6 5912.1 5918.7 5924.6 9077.2 9913.4 9920.3 9937.7 10067.1 9494.5 9730.3 9836.8 9859.2 9865.6 7381.1 7418.7 7459.1 7522.6 7567.1 7144.5 7323.8 7326.1 7439.1 7449.6 9001.7 9050.0 9090.0 9168.0 9209.9 8894.3 9094.7 9268.2 9277.4 9293.9 6231.5 6416.8 6680.8 7020.9 7150.0 7087.9 7112.4 7149.0 7166.1 7190.5 6457.6 6725.5 6759.3 6847.4 6885.2 6618.1 6618.6 6623.2 6684.5 6734.8 6873.0 7050.8 7083.9 7146.1 7162.1 6376.3 6427.9 6436.1 6511.3 6518.8 6642.3 6692.2 6696.2 6712.9 6718.4 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#4] prototype.html Cycles:180 Average:4451.19 Median:5081.54 stddev:1293.66 (25.5%) stddev-sans-first:1259.31 16:18:52 INFO - PROCESS | 6590 | Values: 305.8 309.5 310.4 311.8 317.4 5056.6 5108.5 5131.1 5140.9 5147.1 5048.9 5070.4 5075.6 5078.2 5084.9 3774.5 3850.0 3897.4 3985.9 3992.1 3974.4 3977.3 3977.6 3989.3 3989.6 3947.5 3949.9 3955.3 3963.7 3965.8 3739.9 3811.0 3970.8 3981.5 3986.4 3501.9 3517.6 3518.6 3523.4 3524.5 4893.4 4905.1 4909.9 4913.5 4927.7 4440.5 4543.3 4549.4 4553.9 4554.2 5257.5 5291.7 5297.8 5322.5 5332.9 3813.0 3817.8 3822.8 3824.9 3825.6 5381.1 5556.0 5556.1 5566.2 5581.9 3920.2 3942.8 3945.1 3946.8 3949.2 3996.0 3998.6 4003.0 4004.1 4010.3 4314.4 4459.7 4511.9 4534.6 4546.3 5312.1 5335.8 5336.5 5336.9 5342.3 1369.4 1397.3 1397.9 1400.3 1400.8 891.1 922.2 956.8 970.9 975.1 4576.7 4732.6 4743.1 4783.1 4824.8 5547.6 5553.6 5571.7 5580.0 5581.3 4511.7 4748.4 4749.3 4774.8 4780.5 2915.0 2965.2 2970.3 2972.7 2985.3 5241.7 5243.3 5251.6 5257.3 5265.9 5428.3 5703.3 5714.7 5746.3 5752.2 5260.2 5265.6 5270.7 5279.0 5288.8 5537.1 5561.0 5564.7 5610.0 5620.8 5224.1 5412.3 5415.8 5434.4 5440.6 5206.9 5213.9 5217.3 5227.8 5230.6 3784.8 3824.7 3830.1 3834.7 3856.1 5350.2 5545.6 5555.5 5560.6 5572.2 5348.6 5359.9 5381.4 5389.0 5401.1 5115.5 5385.8 5394.7 5399.7 5405.3 5289.8 5329.5 5332.4 5332.6 5347.2 5065.3 5220.8 5368.7 5369.8 5406.5 5255.4 5290.4 5304.5 5307.5 5313.8 16:18:52 INFO - PROCESS | 6590 | 16:18:52 INFO - PROCESS | 6590 | [#5] yui.html Cycles:180 Average:12537.66 Median:44617.33 stddev:13756.12 (30.8%) stddev-sans-first:13765.99 16:18:52 INFO - PROCESS | 6590 | Values: 699.6 723.4 757.6 764.3 766.3 14048.2 14729.7 14746.3 14758.6 14779.3 13589.6 13681.5 13684.5 13752.0 13811.4 649.2 811.0 814.1 820.5 822.3 841.6 847.1 847.5 847.7 847.9 867.2 874.0 877.1 877.5 877.8 678.0 845.8 862.7 869.8 871.1 633.2 635.6 638.3 638.6 639.9 13395.7 13405.9 13440.3 13441.5 13467.1 11911.2 12206.6 12275.1 12461.8 12472.9 10236.4 10275.3 10352.4 10556.3 10621.3 3342.3 3353.6 3396.1 3399.6 3402.5 46472.1 46777.1 47133.0 47735.3 48092.3 9655.5 9730.9 9798.8 9832.0 9836.6 17164.4 17196.7 17259.8 17349.0 17351.6 6872.2 6890.3 6914.7 6956.7 7114.1 3634.7 3732.1 3840.4 3850.4 3910.7 2826.2 2908.7 2918.3 2922.0 2926.1 508.5 511.2 520.5 521.7 537.1 519.7 563.6 631.8 657.9 671.5 7736.3 7836.5 7917.0 8056.6 8148.8 505.5 577.2 625.9 628.0 655.1 3717.0 3811.2 3855.3 3919.5 3957.9 49079.8 49887.8 49960.8 50183.0 50357.2 43710.6 44455.3 44779.3 45104.1 46139.3 35604.3 37879.4 38897.0 39194.0 41813.4 7463.7 7863.8 7948.0 8118.9 8219.8 27042.5 27140.9 27209.5 28006.9 28394.0 34066.7 34069.0 34106.5 34973.3 35157.0 9573.1 10207.3 10332.3 10400.5 10683.5 10701.5 10886.4 11134.9 11391.4 11631.5 11358.7 11655.6 11773.8 12056.5 12117.8 11381.3 11585.9 11745.4 11941.1 12017.6 10081.3 10301.1 10323.5 10332.6 10641.1 8863.5 9024.6 9136.5 9155.5 9349.4 9476.7 9555.3 9610.3 9856.6 9934.4 16:18:52 INFO - PROCESS | 6590 | -------- Summary: end -------- 16:18:52 INFO - PROCESS | 6590 | 16:18:53 INFO - TEST-INFO | 6590: exit 0 16:18:53 INFO - TEST-OK | dromaeo_css | took 1120051ms 16:18:53 INFO - TEST-START | kraken 16:18:53 INFO - operating with platform_type : linux_ 16:18:53 INFO - Initialising browser for kraken test... 16:18:53 INFO - TEST-INFO | started process 6772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW_K5z/profile http://localhost:39291/getInfo.html) 16:18:59 INFO - PROCESS | 6772 | __metrics Screen width/height:1600/1200 16:18:59 INFO - PROCESS | 6772 | colorDepth:24 16:18:59 INFO - PROCESS | 6772 | Browser inner width/height: 1024/697 16:18:59 INFO - PROCESS | 6772 | __metrics 16:19:00 ERROR - PROCESS | 6772 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:19:01 INFO - TEST-INFO | 6772: exit 0 16:19:01 INFO - Browser initialized. 16:19:01 INFO - Running cycle 1/1 for kraken test... 16:19:01 INFO - TEST-INFO | started process 6855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW_K5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:13 INFO - PROCESS | 6855 | RSS: Main: 154513408 16:19:13 INFO - PROCESS | 6855 | 16:19:15 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:16 INFO - PROCESS | 6855 | RSS: Main: 209244160 16:19:16 INFO - PROCESS | 6855 | 16:19:19 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-dft) 16:19:20 INFO - PROCESS | 6855 | RSS: Main: 194854912 16:19:20 INFO - PROCESS | 6855 | 16:19:23 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-fft) 16:19:24 INFO - PROCESS | 6855 | RSS: Main: 266080256 16:19:24 INFO - PROCESS | 6855 | 16:19:26 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-oscillator) 16:19:26 INFO - PROCESS | 6855 | RSS: Main: 173432832 16:19:26 INFO - PROCESS | 6855 | 16:19:29 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:29 INFO - PROCESS | 6855 | RSS: Main: 177086464 16:19:29 INFO - PROCESS | 6855 | 16:19:32 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:33 INFO - PROCESS | 6855 | RSS: Main: 213958656 16:19:33 INFO - PROCESS | 6855 | 16:19:36 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:37 INFO - PROCESS | 6855 | RSS: Main: 212807680 16:19:37 INFO - PROCESS | 6855 | 16:19:40 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39291/tests/kraken/driver.html?testName=json-parse-financial) 16:19:41 INFO - PROCESS | 6855 | RSS: Main: 213843968 16:19:41 INFO - PROCESS | 6855 | 16:19:42 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:43 INFO - PROCESS | 6855 | RSS: Main: 200253440 16:19:43 INFO - PROCESS | 6855 | 16:19:45 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:45 INFO - PROCESS | 6855 | RSS: Main: 203997184 16:19:45 INFO - PROCESS | 6855 | 16:19:48 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:48 INFO - PROCESS | 6855 | RSS: Main: 218468352 16:19:48 INFO - PROCESS | 6855 | 16:19:51 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:52 INFO - PROCESS | 6855 | RSS: Main: 222961664 16:19:52 INFO - PROCESS | 6855 | 16:19:55 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:55 INFO - PROCESS | 6855 | RSS: Main: 217346048 16:19:55 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39291/tests/kraken/driver.html?testName=ai-astar) 16:19:57 INFO - PROCESS | 6855 | RSS: Main: 281645056 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | __start_tp_report 16:19:57 INFO - PROCESS | 6855 | _x_x_mozilla_page_load 16:19:57 INFO - PROCESS | 6855 | _x_x_mozilla_page_load_details 16:19:57 INFO - PROCESS | 6855 | |i|pagename|runs| 16:19:57 INFO - PROCESS | 6855 | |0;ai-astar;113;115;107;112;113;115;102;113;112;112 16:19:57 INFO - PROCESS | 6855 | |1;audio-beat-detection;163;133;152;182;140;160;157;138;185;136 16:19:57 INFO - PROCESS | 6855 | |2;audio-dft;161;160;162;160;162;162;162;162;161;163 16:19:57 INFO - PROCESS | 6855 | |3;audio-fft;72;76;108;105;83;73;73;104;102;73 16:19:57 INFO - PROCESS | 6855 | |4;audio-oscillator;95;95;149;93;94;93;149;95;94;144 16:19:57 INFO - PROCESS | 6855 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;118;116 16:19:57 INFO - PROCESS | 6855 | |6;imaging-darkroom;154;155;154;154;155;154;155;154;157;155 16:19:57 INFO - PROCESS | 6855 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 16:19:57 INFO - PROCESS | 6855 | |8;json-parse-financial;63;65;64;65;65;64;66;82;63;62 16:19:57 INFO - PROCESS | 6855 | |9;json-stringify-tinderbox;64;63;64;63;63;63;64;63;63;64 16:19:57 INFO - PROCESS | 6855 | |10;stanford-crypto-aes;92;83;83;82;84;84;83;85;86;85 16:19:57 INFO - PROCESS | 6855 | |11;stanford-crypto-ccm;136;137;135;136;134;144;134;140;171;137 16:19:57 INFO - PROCESS | 6855 | |12;stanford-crypto-pbkdf2;179;174;170;171;177;171;173;171;174;176 16:19:57 INFO - PROCESS | 6855 | |13;stanford-crypto-sha256-iterative;74;72;73;72;72;71;71;72;69;73 16:19:57 INFO - PROCESS | 6855 | __end_tp_report 16:19:57 INFO - PROCESS | 6855 | __start_cc_report 16:19:57 INFO - PROCESS | 6855 | _x_x_mozilla_cycle_collect,1916 16:19:57 INFO - PROCESS | 6855 | __end_cc_report 16:19:57 INFO - PROCESS | 6855 | __startTimestamp1460503197667__endTimestamp 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | ------- Summary: start ------- 16:19:57 INFO - PROCESS | 6855 | Number of tests: 14 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.98 (3.5%) stddev-sans-first:4.18 16:19:57 INFO - PROCESS | 6855 | Values: 113.0 115.0 107.0 112.0 113.0 115.0 102.0 113.0 112.0 112.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:158.50 stddev:18.52 (11.7%) stddev-sans-first:19.40 16:19:57 INFO - PROCESS | 6855 | Values: 163.0 133.0 152.0 182.0 140.0 160.0 157.0 138.0 185.0 136.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 16:19:57 INFO - PROCESS | 6855 | Values: 161.0 160.0 162.0 160.0 162.0 162.0 162.0 162.0 161.0 163.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#3] audio-fft Cycles:10 Average:86.90 Median:73.00 stddev:15.74 (21.6%) stddev-sans-first:15.74 16:19:57 INFO - PROCESS | 6855 | Values: 72.0 76.0 108.0 105.0 83.0 73.0 73.0 104.0 102.0 73.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:25.74 (27.4%) stddev-sans-first:26.72 16:19:57 INFO - PROCESS | 6855 | Values: 95.0 95.0 149.0 93.0 94.0 93.0 149.0 95.0 94.0 144.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:19:57 INFO - PROCESS | 6855 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 118.0 116.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#6] imaging-darkroom Cycles:10 Average:154.70 Median:155.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:19:57 INFO - PROCESS | 6855 | Values: 154.0 155.0 154.0 154.0 155.0 154.0 155.0 154.0 157.0 155.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:19:57 INFO - PROCESS | 6855 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:5.78 (8.9%) stddev-sans-first:6.04 16:19:57 INFO - PROCESS | 6855 | Values: 63.0 65.0 64.0 65.0 65.0 64.0 66.0 82.0 63.0 62.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:19:57 INFO - PROCESS | 6855 | Values: 64.0 63.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.83 (3.3%) stddev-sans-first:1.27 16:19:57 INFO - PROCESS | 6855 | Values: 92.0 83.0 83.0 82.0 84.0 84.0 83.0 85.0 86.0 85.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:137.00 stddev:11.17 (8.2%) stddev-sans-first:11.73 16:19:57 INFO - PROCESS | 6855 | Values: 136.0 137.0 135.0 136.0 134.0 144.0 134.0 140.0 171.0 137.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:2.99 (1.7%) stddev-sans-first:2.45 16:19:57 INFO - PROCESS | 6855 | Values: 179.0 174.0 170.0 171.0 177.0 171.0 173.0 171.0 174.0 176.0 16:19:57 INFO - PROCESS | 6855 | 16:19:57 INFO - PROCESS | 6855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.37 (1.9%) stddev-sans-first:1.22 16:19:57 INFO - PROCESS | 6855 | Values: 74.0 72.0 73.0 72.0 72.0 71.0 71.0 72.0 69.0 73.0 16:19:57 INFO - PROCESS | 6855 | -------- Summary: end -------- 16:19:57 INFO - PROCESS | 6855 | 16:19:58 INFO - TEST-INFO | 6855: exit 0 16:19:58 INFO - TEST-OK | kraken | took 65095ms 16:19:58 INFO - SUITE-END | took 1185s 16:19:58 INFO - Completed test suite (00:19:45) 16:19:58 INFO - javascript benchmark 16:19:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.5245255853943, 2703.9459210815785, 2712.796540259481, 2721.5101281769275, 2741.3694850184456, 4632.976835115828, 4703.270992996083, 4731.077439899217, 4741.431028276607, 4759.190937540622, 4638.582527572517, 4676.39206903103, 4739.549742774431, 4748.097861406331, 4761.47623761386, 4294.699371044028, 4297.205017071836, 4336.457942757155, 4361.323994780814, 4457.219986502365, 4388.97805510972, 4416.84541041062, 4429.579189976947, 4462.308342206947, 4474.530174331697, 4252.574742525722, 4283.0363168287195, 4285.078708077778, 4359.411479450266, 4382.189294980423, 4330.0, 4356.172327257811, 4363.105563359503, 4373.737575745466, 4410.0077482566485, 4341.782910854445, 4345.717528360678, 4351.912961740779, 4372.366006928977, 4383.671224658164, 4482.753448560328, 4547.7271363717955, 4620.884477888046, 4628.39830821991, 4640.65195110368, 5096.159133742928, 5102.668326558762, 5119.872003199913, 5123.2315152727015, 5176.482351764794, 5133.563647090002, 5144.4083930348115, 5150.639455238135, 5151.304573882516, 5160.432352441228, 4637.234856248715, 4740.407449068866, 4788.353572267769, 4817.566419022305, 4826.227803551415, 5226.529612334908, 5250.343707036621, 5253.711045892436, 5253.737313134328, 5259.921101183485, 4851.199552073868, 5000.224965130411, 5001.474845141281, 5003.849884503471, 5052.393712754493, 5070.569001634903, 5089.236614507853, 5129.8717532062, 5130.538251557377, 5138.075146473596, 4999.10016197088, 5000.974995125001, 5006.749662516932, 5014.724190169502, 5057.165567681292, 4876.146674332049, 4993.975030124826, 5001.72490513018, 5004.199328107558, 5009.814841638886, 4245.426867372927, 4245.893852653647, 4251.59609837065, 4252.55348188442, 4311.159323931866, 3702.8889133326043, 3709.647583479565, 3744.419614959631, 3752.3058234226755, 3782.7541209821825, 4368.366586844953, 4377.212101821639, 4380.123975204971, 4381.277089280296, 4421.226285400042, 4968.8509344719, 5066.138756411419, 5069.645124841226, 5103.642745007888, 5156.587473002151, 4403.559644035571, 4406.515283318832, 4413.58070983256, 4427.380166776654, 4447.933281000787, 4488.663350248745, 4517.909641807146, 4525.298578720303, 4531.229690952546, 4578.88552786183, 4688.859334219979, 4783.354247176587, 4785.521447855187, 4864.173090574682, 4876.926846097383, 5027.0, 5029.27075574047, 5041.773120209526, 5053.67151135175, 5101.642884998015, 4756.096341695067, 4757.690750101232, 4762.880927976828, 4765.070811191785, 4807.807687692593, 4915.361003069578, 4995.5254250847565, 5035.29505869186, 5048.217526283432, 5069.923951140662, 5010.599152067899, 5024.070546948826, 5030.119729047476, 5042.067217564762, 5083.796648134034, 4825.10735513931, 4861.4895435978715, 4867.829625963074, 4868.075065737498, 4912.803487860446, 4900.730459824744, 4911.459739428588, 4956.355673762532, 4964.379452568429, 4993.4756850530175, 4830.2996065571, 4860.465348811557, 4888.853334399973, 4923.359963204761, 4940.407151141886, 4851.345068415719, 4965.602751779777, 4987.0524600325825, 4994.675346102492, 5045.596352291881, 4780.95219047805, 4821.252705830602, 4848.515148485123, 4892.951070489249, 4897.58370538494], "value": 4651.519068610844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7454145634465, 600.3426248258157, 603.167628672432, 616.9938300616992, 620.4540004795779, 33256.33487330252, 34487.48268775964, 34675.0, 34682.0, 34719.82640086799, 35316.293674126566, 35901.2819743605, 35910.46134307988, 35918.0, 35945.28109437809, 7355.705771769123, 7588.16530181681, 7776.844463110734, 7783.260590243918, 9408.247340212767, 9524.476153811538, 9629.422234665943, 9645.373050751714, 9665.565049572751, 9669.17811985982, 9699.660511882086, 9793.167580755644, 9797.559109840075, 9802.754931126708, 9814.46020468874, 7518.135414427356, 7808.063032436087, 7808.297253247179, 9659.323847330654, 9683.757906052406, 9614.663486778, 9771.511424428822, 9775.169110625606, 9779.119879210904, 9781.434970404773, 33169.0, 33778.6622133778, 33787.324253514795, 33867.830660846535, 33871.15322116942, 3086.2284428892776, 3127.8123312601315, 3202.2634793997513, 3354.6142193647797, 3814.0, 28294.434111317863, 28542.14373568796, 28925.0, 29056.8547157265, 29584.70415295841, 3426.2462258303135, 3429.537012503305, 3474.722022238215, 3505.404081306159, 3541.7166626669805, 208401.0, 209349.9532502343, 209690.0, 209720.0, 209942.0, 31706.207344816565, 50190.49809501931, 50203.497965020615, 50742.492575073775, 50815.74592127016, 31260.218494537363, 31354.372912542076, 31395.84302078475, 31419.915410996426, 31434.68565314363, 12200.084993625514, 12304.323262220663, 12314.384280785926, 12322.322272274932, 12337.444814983348, 9696.466694331739, 10605.84091238632, 10862.891371086345, 10917.727056823484, 10920.836187457195, 7796.4932279401655, 7818.804529886685, 7844.4901081429525, 7915.881261781078, 7916.604169791487, 3172.6510083890753, 3178.300773829754, 3216.1477208539754, 3218.3241519281214, 3248.415285248631, 896.462122726359, 946.9763255918657, 951.8286708392417, 1005.6329439754437, 1062.4634559547533, 26655.600165997526, 28004.859975700398, 28027.823240589376, 28212.0, 28362.71637283642, 968.2496065549255, 1020.1481762728205, 1069.2034434346463, 1073.1951036722458, 1090.929089609173, 14715.411383544539, 14973.925130374497, 14979.525427776773, 15069.401842403055, 15161.545153645407, 135547.0, 137336.0, 137639.0, 303058.0, 304845.0, 46391.768041160256, 47294.29058564124, 47314.290285645744, 47351.0, 47392.28911566329, 1074.4896174317137, 1177.0877569883237, 1238.0900038471716, 1262.955796547135, 1271.5168236070233, 26009.0, 27269.59095613607, 27611.368274351218, 27665.72334276712, 27871.303217419725, 37766.24467510689, 37881.62118378891, 38220.235595287384, 38253.218347706534, 38309.808450958684, 214984.0, 215510.0, 215519.0, 215695.0, 216163.0, 22187.445313867283, 24472.87763561171, 25082.247532574052, 25092.247232583053, 25095.121670741435, 38264.0, 38542.80728596339, 38843.80578097091, 39445.80277098596, 39447.408288876264, 33548.0, 33584.83207583946, 33657.663423365455, 34031.48952765661, 34416.65583344134, 32946.0, 33337.666623333454, 33368.0, 33540.49689254712, 33549.329013419105, 33315.83342083274, 33611.99164025083, 33697.326053479286, 34076.31847362989, 34132.0, 29682.55476167816, 31216.738572034035, 35008.29983400369, 35123.47314790229, 35141.47287790736, 24265.39336516601, 24686.876565617058, 24781.25656230316, 25148.74851251464, 25183.74816251814], "value": 15883.478948676146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7617831785226, 358.7058611938212, 359.6673077403401, 363.26076434455877, 371.58197028343113, 15541.300641471147, 15636.296366663513, 16556.75164872528, 16648.0, 16661.91669041656, 16060.437884674038, 16734.497965061037, 16859.747103793452, 16906.408275710353, 16906.830931690678, 5021.0, 5264.684118952875, 5311.176767601028, 5315.521603055724, 5322.20166974953, 3677.3196958562617, 3882.1265215326466, 5215.061288967984, 5596.076647353182, 5943.70281485924, 5875.941240587604, 5887.8233652990475, 5888.499477544414, 5900.852478688024, 5912.17229587858, 5645.463680950324, 6104.114903338991, 6104.633721976696, 6109.114178444145, 6110.511159107261, 3348.2131699050706, 4800.4719480857075, 5105.157648987913, 5118.206677964921, 5340.065488539529, 17928.0, 18817.717734233862, 18845.434636960912, 18974.71537926932, 18994.24023039077, 1923.4998900285887, 1925.711143328512, 1948.9512762180916, 1971.5958228563254, 2052.95894082119, 11881.0, 12155.696107597292, 12283.631491055283, 12395.194312369667, 12589.811152832715, 1712.8544073753746, 1742.6079132195282, 1756.6223261998605, 1844.2807305151002, 1847.5288801355568, 63088.684556577384, 64010.67994659997, 64200.0, 65155.674221628586, 71647.64176179138, 14626.49089767739, 15159.772603410958, 15168.165750883807, 15239.304151403692, 15521.0, 29327.0, 29479.705202948124, 29719.0, 29726.851365743034, 29770.255743606584, 8513.106123856905, 8737.776711260429, 8797.38418310725, 8845.955770221108, 8890.688825891191, 7029.22678505364, 7133.643317834191, 7234.855302893912, 7259.818504537323, 7282.635868206568, 8234.258916697527, 8300.89626125327, 8323.791905202419, 8347.290480309242, 8384.958075209584, 2817.3801763611973, 3277.3609146216736, 3356.8992930212135, 3400.803244949739, 3430.776999495025, 785.2618538573722, 869.6260607938647, 899.3974037394961, 957.0333962697725, 966.1497881863914, 14953.626159346104, 15007.624809379853, 16615.3353865844, 16673.0, 16882.74675879863, 847.877057826624, 854.3080105114752, 858.5578427110044, 881.5504092912661, 914.6707185413246, 8962.82074358509, 9295.58169882357, 9343.579538920765, 9420.481873496887, 9491.620335186653, 377729.0, 381220.0, 383817.0, 387972.0, 389278.0, 76146.61926690442, 76220.23779762132, 76372.0, 76884.61557692288, 77612.17908656874, 907.160876189522, 919.4758987377131, 921.1019256225261, 927.6567669962158, 931.3247895276006, 14472.131672099707, 14578.232474982082, 14578.416863325348, 14609.707805844037, 14941.178235197169, 31537.634677399747, 32643.836780815946, 32713.836430818646, 32869.50695739518, 33315.83342083371, 44488.33267501055, 45570.772146139054, 45575.0, 45577.088458229984, 45634.54365456436, 7284.526505777108, 7307.196208417176, 7344.30229128232, 7382.077240344957, 7451.2176221495965, 6231.5637905348, 8064.798380040546, 10037.648682296085, 10381.377117372982, 10612.946935265274, 9018.09819018093, 9134.954325228331, 9145.588448519966, 9248.861267081134, 9616.507496659793, 8860.0, 8954.731358059269, 8977.192052715287, 9164.358494905558, 9274.397164184307, 5364.785408583613, 7262.6731797068205, 9130.634774608941, 9354.362986477476, 9626.0, 6653.403183235891, 6722.9663851680425, 6767.39093481589, 7136.000959865727, 7243.261617211937, 7886.487378320391, 9436.811263774549, 9493.325934220522, 9836.803263934538, 10402.687919362432], "value": 8540.213358328063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.178765590022, 1421.644588852787, 1429.0354011042548, 1591.734571016042, 1788.7406326082726, 6721.26066132725, 7590.468667193299, 7789.92210077899, 7800.921990780083, 7808.8047798805055, 7454.515456495324, 7454.88817667734, 7537.24627537246, 7555.848883022336, 7582.128055273645, 1937.7868434472198, 2220.145244081032, 2242.955140897181, 2247.0000849621924, 2332.9883350583223, 2279.225063478417, 2298.9885050574726, 2300.7584203658625, 2303.562323158603, 2305.227748704186, 2209.0, 2264.230161745006, 2265.558216147852, 2267.557826223887, 2268.2061278552455, 1897.8671492995427, 2180.487585417418, 2262.242148880127, 2265.7394399644086, 2266.8413211075067, 2228.097620463715, 2228.7882651148116, 2235.2176738141684, 2236.8657880527057, 2275.6472746724285, 7604.4296677748835, 7610.8477830443635, 7664.425168112358, 7680.6159692015735, 7699.769006929801, 4414.337849322627, 4582.083583283356, 4607.723536587815, 4615.930761038587, 4678.532146785295, 2994.9634248710868, 3018.0794857568435, 3033.1507177990197, 3069.723724864773, 3073.4160509503345, 951.7691243328694, 957.8275910336137, 970.3013830042358, 979.3536266064434, 987.2200961240611, 10810.675679729542, 10829.945850270777, 10861.5112319945, 10874.18443616732, 10890.61882834105, 4215.515215750167, 4339.435873336446, 4367.8861890217795, 4379.540148284448, 4524.47968483622, 8367.832643347221, 8394.580270986426, 8405.621747021398, 8442.071372149181, 8463.788405289793, 4040.2727509048063, 4525.140223357552, 4564.475085365159, 4568.0, 4578.0, 4069.3895915612893, 4209.831606735757, 4215.156968606291, 4222.831086756557, 4247.97876010618, 3509.3332266869215, 3543.1496440854007, 3594.155373487228, 3617.8733744318824, 3669.7614655047337, 1046.9528871200814, 1087.331291255872, 1091.2797553614575, 1093.8031154392127, 1111.7387413957713, 1235.1600911380167, 1235.6910772306924, 1256.654420034498, 1258.7167887225485, 1277.5975567696146, 7374.151972523228, 7447.88828167578, 7500.212477689873, 7519.060117485315, 7532.698692052366, 457.72307753809133, 467.75910406140866, 468.09890959902054, 468.2461237407771, 472.15248628711544, 5651.943480565142, 5870.5890587659305, 5912.054071348563, 5918.674472904032, 5924.555658325557, 9077.183053525214, 9913.405195688138, 9920.255980801325, 9937.7018689438, 10067.144292735053, 9494.477803720862, 9730.318877678494, 9836.754081147885, 9859.161971232383, 9865.556049977768, 7381.077365329334, 7418.666160022812, 7459.142198647117, 7522.623868806538, 7567.129780075252, 7144.535605185646, 7323.780286591411, 7326.120865496175, 7439.070116235471, 7449.5902725350625, 9001.684941027033, 9050.049744776703, 9090.0, 9168.0, 9209.86185207209, 8894.33292503052, 9094.681686140953, 9268.212201962908, 9277.350585458953, 9293.907060929574, 6231.532635052298, 6416.807495775134, 6680.766173183915, 7020.929790702027, 7150.0, 7087.893681594884, 7112.35988761014, 7149.034880291302, 7166.068411106523, 7190.496665233383, 6457.644829534421, 6725.529212955242, 6759.256481787098, 6847.417969472651, 6885.208201056943, 6618.139641846529, 6618.63597502142, 6623.172103487064, 6684.498662600227, 6734.797956061326, 6872.965635171792, 7050.753223637148, 7083.858322833411, 7146.071010768567, 7162.068931038932, 6376.330485299162, 6427.871442571216, 6436.066770318184, 6511.3163117871945, 6518.837029074311, 6642.335766423513, 6692.196936367667, 6696.229933557508, 6712.899306510309, 6718.361755633207], "value": 4358.519306430775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8486049405545, 309.52178883624805, 310.3947302759619, 311.826936050492, 317.4143704864524, 5056.646034777567, 5108.540231379176, 5131.102057139995, 5140.922886156711, 5147.124988751912, 5048.924266136001, 5070.366204224472, 5075.593952483801, 5078.1874900016, 5084.898302033957, 3774.5470543534675, 3850.0, 3897.376419772837, 3985.880423587297, 3992.1017771001584, 3974.3641017437217, 3977.2840888640035, 3977.6221258980495, 3989.321815291393, 3989.6209860063245, 3947.4868267125235, 3949.881503554898, 3955.3078211312904, 3963.742356746802, 3965.781881996489, 3739.906502337436, 3810.961890381116, 3970.7816070116132, 3981.4824072870633, 3986.40203969404, 3501.8949431517094, 3517.595476520182, 3518.577770667511, 3523.3834079036064, 3524.488949102366, 4893.388326459192, 4905.117078925792, 4909.926351104737, 4913.525942217356, 4927.728974906378, 4440.467143942716, 4543.273076307775, 4549.363089167519, 4553.863384098482, 4554.203014472454, 5257.5005374489365, 5291.656042357235, 5297.7880884764945, 5322.547583455411, 5332.866678333034, 3813.046738315421, 3817.828197731109, 3822.847086116552, 3824.8852534424013, 3825.5791862895057, 5381.112116500773, 5556.0, 5556.083246264361, 5566.2207290979295, 5581.944180558224, 3920.2355540669864, 3942.802859857053, 3945.0926286954164, 3946.7631942082994, 3949.170674158459, 3995.9800200998807, 3998.580149084304, 4003.0, 4004.1391100913443, 4010.2981978153707, 4314.352847072902, 4459.687821852439, 4511.932321015187, 4534.6372290216705, 4546.29532422475, 5312.123499622597, 5335.838985210996, 5336.546393556514, 5336.893262134813, 5342.305500284938, 1369.4385302026121, 1397.3362652739868, 1397.9231142287272, 1400.2858542143376, 1400.8319001719656, 891.1355984694835, 922.1792604581927, 956.7512446763892, 970.8689326940914, 975.1321324021626, 4576.656750743708, 4732.5977291929885, 4743.075100355467, 4783.1390349737385, 4824.782884770124, 5547.583931205176, 5553.611247212737, 5571.693556854412, 5579.972100139474, 5581.302337207849, 4511.684182107221, 4748.406449193851, 4749.335093086971, 4774.7851346688785, 4780.49804770501, 2914.9708502915123, 2965.154930844742, 2970.2722832906074, 2972.673005969342, 2985.283531952359, 5241.659292145999, 5243.292155559027, 5251.553617942442, 5257.263983042377, 5265.921011184835, 5428.348598168245, 5703.258576385043, 5714.714264286852, 5746.2529871116485, 5752.223449834219, 5260.237265596544, 5265.6050796189675, 5270.657407268515, 5279.0, 5288.81489147878, 5537.065355361665, 5560.972195138998, 5564.666120032811, 5610.0, 5620.803271885465, 5224.05966925957, 5412.269343638558, 5415.810446634349, 5434.429384914527, 5440.591955603267, 5206.895862082662, 5213.895722085613, 5217.295665085317, 5227.817026404057, 5230.607704422259, 3784.8296826642318, 3824.7322687411615, 3830.084957521239, 3834.7123965702126, 3856.132370216791, 5350.197470379474, 5545.584081193846, 5555.50000499957, 5560.610757246954, 5572.164175373727, 5348.5988550858065, 5359.892802144013, 5381.381141168659, 5389.0, 5401.135818269058, 5115.488451154854, 5385.838424847261, 5394.730263486888, 5399.676019438846, 5405.297311349499, 5289.788408463618, 5329.467053294639, 5332.386775520865, 5332.6000549958135, 5347.1979203119845, 5065.29085927963, 5220.765065571983, 5368.7047212403695, 5369.785208591613, 5406.459354064562, 5255.448177941414, 5290.365156181129, 5304.522592966651, 5307.495787900143, 5313.840584782462], "value": 4041.7457769395096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6047233313176, 723.4284914917216, 757.6439073635389, 764.2739397572304, 766.2911806578913, 14048.227347495884, 14729.705405891877, 14746.336414861331, 14758.557243282692, 14779.26103694815, 13589.592312230625, 13681.452741890338, 13684.52104176354, 13752.0, 13811.447542098304, 649.2014821769227, 810.9797255068612, 814.0556953933409, 820.4666966471782, 822.2558584481025, 841.6128580852784, 847.1020718038868, 847.525385783963, 847.7117779954814, 847.9067302596709, 867.1501928110424, 873.9519326437044, 877.1009715042069, 877.5261358866204, 877.7893305606673, 678.0, 845.8477474054667, 862.7282406042108, 869.7999460124175, 871.0897112517434, 633.2306247908813, 635.5995722694673, 638.3201889987196, 638.6423602782456, 639.859230969186, 13395.732085358239, 13405.932970335087, 13440.260785656785, 13441.462341506329, 13467.12463689857, 11911.225770324987, 12206.633800985985, 12275.140740148194, 12461.75076498474, 12472.875271247261, 10236.43699596522, 10275.332103413255, 10352.4306163161, 10556.261061725681, 10621.25651204416, 3342.3148254607745, 3353.6311005789344, 3396.100033491127, 3399.5750531183603, 3402.4556071028765, 46472.070558588974, 46777.064458710636, 47133.0, 47735.283970740464, 48092.27861582079, 9655.468949207721, 9730.854037189449, 9798.804023919623, 9831.950840245752, 9836.60653573849, 17164.39924602633, 17196.656066878593, 17259.827401726074, 17349.0, 17351.56621084483, 6872.175338959357, 6890.345417185359, 6914.688839002257, 6956.65216739161, 7114.110736157981, 3634.745567810228, 3732.141607430306, 3840.423936409505, 3850.441685955521, 3910.7458015228917, 2826.1804076817903, 2908.6509618845453, 2918.3287843796047, 2922.0357282097284, 2926.078285340111, 508.47118996244234, 511.2127323921194, 520.4795204795205, 521.6817741177879, 537.0842713174029, 519.7037688517509, 563.5688698145922, 631.7514713551421, 657.9309172536911, 671.5433505216499, 7736.342410895025, 7836.490628109154, 7916.960415197887, 8056.597170141469, 8148.837023259502, 505.48945564979635, 577.151587166864, 625.8935980883169, 627.9937200628027, 655.1090516897016, 3716.962830371716, 3811.1996480739354, 3855.2867719471988, 3919.451276821247, 3957.920841583152, 49079.754601227476, 49887.75056124696, 49960.750196249515, 50183.0, 50357.244641330406, 43710.56289437129, 44455.33317000248, 44779.328310075376, 45104.09791804211, 46139.30791038137, 35604.28791424157, 37879.431808522895, 38897.0, 39194.0, 41813.37279940803, 7463.701451941862, 7863.803404914923, 7948.046234451903, 8118.9188108120525, 8219.753407397788, 27042.459150817267, 27140.864295678395, 27209.455810883275, 28006.85996570004, 28394.006209782558, 34066.65933340635, 34069.0, 34106.48840267348, 34973.300533988666, 35157.0, 9573.138417542455, 10207.336523125972, 10332.276740628084, 10400.531976061247, 10683.542785159301, 10701.518431670438, 10886.40124793144, 11134.944325278646, 11391.373474458984, 11631.47658355359, 11358.716032099264, 11655.592054278399, 11773.76452470963, 12056.457459414523, 12117.75764484723, 11381.317120972768, 11585.88414115848, 11745.412729363668, 11941.104417168921, 12017.63947081589, 10081.344712593658, 10301.124404425707, 10323.48382580883, 10332.638357657446, 10641.095506882002, 8863.468191908249, 9024.59389327495, 9136.451812891248, 9155.450672959643, 9349.439033658002, 9476.715698529055, 9555.283353748358, 9610.279229057709, 9856.556454959687, 9934.354266972623], "value": 5973.218915254272, "unit": "score"}], "name": "dromaeo_css", "value": 6363.478337519256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 107.0, 112.0, 113.0, 115.0, 102.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 152.0, 182.0, 140.0, 160.0, 157.0, 138.0, 185.0, 136.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 108.0, 105.0, 83.0, 73.0, 73.0, 104.0, 102.0, 73.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 149.0, 93.0, 94.0, 93.0, 149.0, 95.0, 94.0, 144.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 154.0, 154.0, 155.0, 154.0, 155.0, 154.0, 157.0, 155.0], "value": 154.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0, 82.0, 63.0, 62.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 83.0, 82.0, 84.0, 84.0, 83.0, 85.0, 86.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 135.0, 136.0, 134.0, 144.0, 134.0, 140.0, 171.0, 137.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 174.0, 170.0, 171.0, 177.0, 171.0, 173.0, 171.0, 174.0, 176.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 72.0, 72.0, 71.0, 71.0, 72.0, 69.0, 73.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1591.0000000000002, "alertThreshold": 2.0}]} 16:19:58 INFO - Return code: 0 16:19:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:58 ERROR - # TBPL SUCCESS # 16:19:58 INFO - Running post-action listener: _resource_record_post_action 16:19:58 INFO - Running post-run listener: _resource_record_post_run 16:20:00 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 208896; Write bytes: 303218688; Read time: 492; Write time: 433476 16:20:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14016512; Read time: 0; Write time: 2588 16:20:00 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 208896; Write bytes: 289202176; Read time: 492; Write time: 430888 16:20:00 INFO - Running post-run listener: _upload_blobber_files 16:20:00 INFO - Blob upload gear active. 16:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:20:00 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 16:20:00 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'] 16:20:00 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 16:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:01 INFO - (blobuploader) - INFO - Done attempting. 16:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:03 INFO - (blobuploader) - INFO - Done attempting. 16:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:03 INFO - Return code: 0 16:20:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfefab76927ebee876f2bdadfd86d2cb2f45cda699f2eab818731ea0734711d1de8518acba77a99dc4bf917694a8d18977417a10f10274e7b750855cf53d17b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2493af48dbcaa00b29af8acde05533c1d20111d2b7550814ca3dfafec8cb76427d7d6c53a8f3642ce2750704422cba409ab07839bbe82af8d141b1853a38dd6"} 16:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:20:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:20:03 INFO - Contents: 16:20:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfefab76927ebee876f2bdadfd86d2cb2f45cda699f2eab818731ea0734711d1de8518acba77a99dc4bf917694a8d18977417a10f10274e7b750855cf53d17b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2493af48dbcaa00b29af8acde05533c1d20111d2b7550814ca3dfafec8cb76427d7d6c53a8f3642ce2750704422cba409ab07839bbe82af8d141b1853a38dd6"} 16:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:03 INFO - Copying logs to upload dir... 16:20:03 INFO - mkdir: /builds/slave/test/build/upload/logs 16:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.163921 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-12 16:20:03.174494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 16:20:03.182434) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 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/8dfefab76927ebee876f2bdadfd86d2cb2f45cda699f2eab818731ea0734711d1de8518acba77a99dc4bf917694a8d18977417a10f10274e7b750855cf53d17b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2493af48dbcaa00b29af8acde05533c1d20111d2b7550814ca3dfafec8cb76427d7d6c53a8f3642ce2750704422cba409ab07839bbe82af8d141b1853a38dd6"} build_url:https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/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/8dfefab76927ebee876f2bdadfd86d2cb2f45cda699f2eab818731ea0734711d1de8518acba77a99dc4bf917694a8d18977417a10f10274e7b750855cf53d17b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2493af48dbcaa00b29af8acde05533c1d20111d2b7550814ca3dfafec8cb76427d7d6c53a8f3642ce2750704422cba409ab07839bbe82af8d141b1853a38dd6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 16:20:03.207861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:20:03.211207) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460500968.590038-258172727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002955 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:20:03.257635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 16:20:03.257939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 16:20:03.261250) ========= ========= Total master_lag: 0.40 =========