builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1460385738.79 results: success (0) buildid: 20160411065021 builduid: 1b2fb46e10d94eb486a49d525ebe09a7 revision: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.788222) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.789291) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.790039) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006341 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.837490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.837887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.904885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.905395) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.982701) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.983323) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.983963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:18.984284) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 07:42:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-11 07:42:19 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162850 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:19.177489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:19.178241) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014659 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:19.255747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:19.256599) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --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 d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 07:42:19,454 truncating revision to first 12 chars 2016-04-11 07:42:19,454 Setting DEBUG logging. 2016-04-11 07:42:19,454 attempt 1/10 2016-04-11 07:42:19,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d93a1bc94513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 07:42:19,921 unpacking tar archive at: fx-team-d93a1bc94513/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783349 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:20.069312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:20.069711) ========= echo d93a1bc945137dfcc94866f1e30da1f55cfb8d9d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d'] 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d93a1bc945137dfcc94866f1e30da1f55cfb8d9d program finished with exit code 0 elapsedTime=0.004718 script_repo_revision: 'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:20.145946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:20.146327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 07:42:20.202381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-11 07:42:20.202823) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:42:20 INFO - MultiFileLogger online at 20160411 07:42:20 in /builds/slave/test 07:42:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 07:42:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:20 INFO - {'append_to_log': False, 07:42:20 INFO - 'base_work_dir': '/builds/slave/test', 07:42:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:42:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:20 INFO - 'branch': 'Fx-Team-Non-PGO', 07:42:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:20 INFO - 'config_files': ('talos/linux_config.py',), 07:42:20 INFO - 'default_actions': ('clobber', 07:42:20 INFO - 'read-buildbot-config', 07:42:20 INFO - 'download-and-extract', 07:42:20 INFO - 'populate-webroot', 07:42:20 INFO - 'create-virtualenv', 07:42:20 INFO - 'install', 07:42:20 INFO - 'run-tests'), 07:42:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:20 INFO - 'download_minidump_stackwalk': True, 07:42:20 INFO - 'download_symbols': 'ondemand', 07:42:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:20 INFO - 'installer_path': 'installer.exe', 07:42:20 INFO - 'log_level': 'info', 07:42:20 INFO - 'log_name': 'talos', 07:42:20 INFO - 'log_to_console': True, 07:42:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:42:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:42:20 INFO - 'opt_config_files': (), 07:42:20 INFO - 'pip_index': False, 07:42:20 INFO - 'sps_profile': False, 07:42:20 INFO - 'sps_profile_interval': 0, 07:42:20 INFO - 'suite': 'dromaeojs-e10s', 07:42:20 INFO - 'system_bits': '32', 07:42:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:20 INFO - 'title': 'talos-linux64-ix-035', 07:42:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:20 INFO - 'use_talos_json': True, 07:42:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:20 INFO - 'work_dir': 'build'} 07:42:20 INFO - ##### 07:42:20 INFO - ##### Running clobber step. 07:42:20 INFO - ##### 07:42:20 INFO - Running pre-action listener: _resource_record_pre_action 07:42:20 INFO - Running main action method: clobber 07:42:20 INFO - rmtree: /builds/slave/test/build 07:42:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - ##### 07:42:21 INFO - ##### Running read-buildbot-config step. 07:42:21 INFO - ##### 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: read_buildbot_config 07:42:21 INFO - Using buildbot properties: 07:42:21 INFO - { 07:42:21 INFO - "project": "", 07:42:21 INFO - "product": "firefox", 07:42:21 INFO - "script_repo_revision": "production", 07:42:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:42:21 INFO - "repository": "", 07:42:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:42:21 INFO - "buildid": "20160411065021", 07:42:21 INFO - "pgo_build": "False", 07:42:21 INFO - "basedir": "/builds/slave/test", 07:42:21 INFO - "buildnumber": 1130, 07:42:21 INFO - "slavename": "talos-linux64-ix-035", 07:42:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:42:21 INFO - "platform": "ubuntu64_hw", 07:42:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:42:21 INFO - "branch": "fx-team", 07:42:21 INFO - "repo_path": "integration/fx-team", 07:42:21 INFO - "revision": "d93a1bc945137dfcc94866f1e30da1f55cfb8d9d", 07:42:21 INFO - "stage_platform": "linux64", 07:42:21 INFO - "builduid": "1b2fb46e10d94eb486a49d525ebe09a7", 07:42:21 INFO - "slavebuilddir": "test" 07:42:21 INFO - } 07:42:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - ##### 07:42:21 INFO - ##### Running download-and-extract step. 07:42:21 INFO - ##### 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: download_and_extract 07:42:21 INFO - mkdir: /builds/slave/test/build/tests 07:42: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')]} 07:42:21 INFO - https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:22 INFO - Downloaded 1361 bytes. 07:42:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:42:22 INFO - Using the following test package requirements: 07:42:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:42:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:42:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:42:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'jsshell-linux-x86_64.zip'], 07:42:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:42:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:42:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:42:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:42:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:42:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:42:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:42:22 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')]} 07:42:22 INFO - https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:26 INFO - Downloaded 22190501 bytes. 07:42:26 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'] 07:42:26 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 07:42:27 INFO - Return code: 0 07:42:27 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 07:42:27 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')]} 07:42:27 INFO - https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:29 INFO - Downloaded 22190501 bytes. 07:42:29 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'] 07:42:29 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 07:42:31 INFO - Return code: 0 07:42:31 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')]} 07:42:31 INFO - https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:42:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:42:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:42:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:33 INFO - Downloaded 10841046 bytes. 07:42:33 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'] 07:42:33 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 07:42:34 INFO - Return code: 0 07:42:34 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')]} 07:42:34 INFO - https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/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 07:42:35 INFO - Downloaded 54098058 bytes. 07:42:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:42:35 INFO - mkdir: /builds/slave/test/properties 07:42:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:35 INFO - Contents: 07:42:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:42:36 INFO - Running post-action listener: _resource_record_post_action 07:42:36 INFO - Running post-action listener: set_extra_try_arguments 07:42:36 INFO - ##### 07:42:36 INFO - ##### Running populate-webroot step. 07:42:36 INFO - ##### 07:42:36 INFO - Running pre-action listener: _resource_record_pre_action 07:42:36 INFO - Running main action method: populate_webroot 07:42:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:42:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:42:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:42:36 INFO - '--tppagecycles', 07:42:36 INFO - '7'], 07:42:36 INFO - 'tests': ['tsvgm']}}, 07:42:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:42:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:42:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:42:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:42:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['damp', 'tps']}, 07:42:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'tests': ['damp', 'tps']}, 07:42:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['dromaeo_dom']}, 07:42:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:42:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['a11yr', 07:42:36 INFO - 'ts_paint', 07:42:36 INFO - 'tpaint', 07:42:36 INFO - 'sessionrestore', 07:42:36 INFO - 'sessionrestore_no_auto_restore', 07:42:36 INFO - 'tabpaint']}, 07:42:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['tsvgx', 07:42:36 INFO - 'tsvgr_opacity', 07:42:36 INFO - 'tart', 07:42:36 INFO - 'tscrollx', 07:42:36 INFO - 'cart']}, 07:42:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:42:36 INFO - 'tsvgr_opacity', 07:42:36 INFO - 'tart', 07:42:36 INFO - 'tscrollx', 07:42:36 INFO - 'cart']}, 07:42:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'talos_options': ['--disable-e10s'], 07:42:36 INFO - 'tests': ['tp5o']}, 07:42:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'tests': ['tp5o']}, 07:42:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'talos_options': ['--disable-e10s', 07:42:36 INFO - '--xperf_path', 07:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:36 INFO - 'tests': ['tp5n']}, 07:42:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:36 INFO - 'talos_options': ['--xperf_path', 07:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:36 INFO - 'tests': ['tp5n']}}, 07:42:36 INFO - 'talos.zip': {'path': '', 07:42:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:42:36 INFO - Running post-action listener: _resource_record_post_action 07:42:36 INFO - ##### 07:42:36 INFO - ##### Running create-virtualenv step. 07:42:36 INFO - ##### 07:42:36 INFO - Running pre-action listener: _resource_record_pre_action 07:42:36 INFO - Running main action method: create_virtualenv 07:42:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:42:36 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 07:42:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:42:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:42:36 INFO - Using real prefix '/usr' 07:42:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:42:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:39 INFO - Installing pip.................done. 07:42:39 INFO - Return code: 0 07:42:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:39 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')]} 07:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:39 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')]} 07:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:39 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:39 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 07:42:39 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 07:42:39 INFO - Using env: {'DISPLAY': ':0', 07:42:39 INFO - 'HOME': '/home/cltbld', 07:42:39 INFO - 'LANG': 'en_US.UTF-8', 07:42:39 INFO - 'LANGUAGE': 'en_US:en', 07:42:39 INFO - 'LOGNAME': 'cltbld', 07:42:39 INFO - 'MAIL': '/var/mail/cltbld', 07:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:39 INFO - 'MOZ_NO_REMOTE': '1', 07:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:39 INFO - 'NO_EM_RESTART': '1', 07:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:39 INFO - 'PWD': '/builds/slave/test', 07:42:39 INFO - 'SHELL': '/bin/bash', 07:42:39 INFO - 'SHLVL': '1', 07:42:39 INFO - 'TERM': 'linux', 07:42:39 INFO - 'TMOUT': '86400', 07:42:39 INFO - 'USER': 'cltbld', 07:42:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:39 INFO - '_': '/tools/buildbot/bin/python'} 07:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:39 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 07:42:39 INFO - Cleaning up... 07:42:39 INFO - Return code: 0 07:42:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:42:39 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')]} 07:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:39 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')]} 07:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:39 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:39 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 07:42:39 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 07:42:39 INFO - Using env: {'DISPLAY': ':0', 07:42:39 INFO - 'HOME': '/home/cltbld', 07:42:39 INFO - 'LANG': 'en_US.UTF-8', 07:42:39 INFO - 'LANGUAGE': 'en_US:en', 07:42:39 INFO - 'LOGNAME': 'cltbld', 07:42:39 INFO - 'MAIL': '/var/mail/cltbld', 07:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:39 INFO - 'MOZ_NO_REMOTE': '1', 07:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:39 INFO - 'NO_EM_RESTART': '1', 07:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:39 INFO - 'PWD': '/builds/slave/test', 07:42:39 INFO - 'SHELL': '/bin/bash', 07:42:39 INFO - 'SHLVL': '1', 07:42:39 INFO - 'TERM': 'linux', 07:42:39 INFO - 'TMOUT': '86400', 07:42:39 INFO - 'USER': 'cltbld', 07:42:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:39 INFO - '_': '/tools/buildbot/bin/python'} 07:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:39 INFO - Downloading/unpacking psutil>=0.7.1 07:42:39 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 07:42:39 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 07:42:39 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 07:42:39 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 07:42:39 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 07:42:39 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 07:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:42 INFO - Installing collected packages: psutil 07:42:42 INFO - Running setup.py install for psutil 07:42:42 INFO - building 'psutil._psutil_linux' extension 07:42:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:42:42 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 07:42:42 INFO - building 'psutil._psutil_posix' extension 07:42:42 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 07:42:42 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 07:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:42 INFO - Successfully installed psutil 07:42:42 INFO - Cleaning up... 07:42:42 INFO - Return code: 0 07:42:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:42 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:42 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 07:42:42 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 07:42:42 INFO - Using env: {'DISPLAY': ':0', 07:42:42 INFO - 'HOME': '/home/cltbld', 07:42:42 INFO - 'LANG': 'en_US.UTF-8', 07:42:42 INFO - 'LANGUAGE': 'en_US:en', 07:42:42 INFO - 'LOGNAME': 'cltbld', 07:42:42 INFO - 'MAIL': '/var/mail/cltbld', 07:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:42 INFO - 'MOZ_NO_REMOTE': '1', 07:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:42 INFO - 'NO_EM_RESTART': '1', 07:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:42 INFO - 'PWD': '/builds/slave/test', 07:42:42 INFO - 'SHELL': '/bin/bash', 07:42:42 INFO - 'SHLVL': '1', 07:42:42 INFO - 'TERM': 'linux', 07:42:42 INFO - 'TMOUT': '86400', 07:42:42 INFO - 'USER': 'cltbld', 07:42:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:42 INFO - '_': '/tools/buildbot/bin/python'} 07:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:42:45 INFO - Installing collected packages: mozsystemmonitor 07:42:45 INFO - Running setup.py install for mozsystemmonitor 07:42:45 INFO - Successfully installed mozsystemmonitor 07:42:45 INFO - Cleaning up... 07:42:45 INFO - Return code: 0 07:42:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:45 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:45 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 07:42:45 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 07:42:45 INFO - Using env: {'DISPLAY': ':0', 07:42:45 INFO - 'HOME': '/home/cltbld', 07:42:45 INFO - 'LANG': 'en_US.UTF-8', 07:42:45 INFO - 'LANGUAGE': 'en_US:en', 07:42:45 INFO - 'LOGNAME': 'cltbld', 07:42:45 INFO - 'MAIL': '/var/mail/cltbld', 07:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:45 INFO - 'MOZ_NO_REMOTE': '1', 07:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:45 INFO - 'NO_EM_RESTART': '1', 07:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:45 INFO - 'PWD': '/builds/slave/test', 07:42:45 INFO - 'SHELL': '/bin/bash', 07:42:45 INFO - 'SHLVL': '1', 07:42:45 INFO - 'TERM': 'linux', 07:42:45 INFO - 'TMOUT': '86400', 07:42:45 INFO - 'USER': 'cltbld', 07:42:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:45 INFO - '_': '/tools/buildbot/bin/python'} 07:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:45 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 07:42:45 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 07:42:45 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 07:42:45 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 07:42:45 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 07:42:45 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 07:42:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:48 INFO - Downloading docopt-0.6.1.tar.gz 07:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:48 INFO - Running setup.py install for blobuploader 07:42:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:48 INFO - Running setup.py install for requests 07:42:49 INFO - Running setup.py install for docopt 07:42:49 INFO - Successfully installed blobuploader requests docopt 07:42:49 INFO - Cleaning up... 07:42:49 INFO - Return code: 0 07:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:49 INFO - Using env: {'DISPLAY': ':0', 07:42:49 INFO - 'HOME': '/home/cltbld', 07:42:49 INFO - 'LANG': 'en_US.UTF-8', 07:42:49 INFO - 'LANGUAGE': 'en_US:en', 07:42:49 INFO - 'LOGNAME': 'cltbld', 07:42:49 INFO - 'MAIL': '/var/mail/cltbld', 07:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:49 INFO - 'MOZ_NO_REMOTE': '1', 07:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:49 INFO - 'NO_EM_RESTART': '1', 07:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:49 INFO - 'PWD': '/builds/slave/test', 07:42:49 INFO - 'SHELL': '/bin/bash', 07:42:49 INFO - 'SHLVL': '1', 07:42:49 INFO - 'TERM': 'linux', 07:42:49 INFO - 'TMOUT': '86400', 07:42:49 INFO - 'USER': 'cltbld', 07:42:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:49 INFO - '_': '/tools/buildbot/bin/python'} 07:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:49 INFO - Running setup.py (path:/tmp/pip-HzJeuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:49 INFO - Running setup.py (path:/tmp/pip-fI5_eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:49 INFO - Running setup.py (path:/tmp/pip-qCIuF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:49 INFO - Running setup.py (path:/tmp/pip-phS5Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:49 INFO - Running setup.py (path:/tmp/pip-DPNAm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:49 INFO - Running setup.py (path:/tmp/pip-zi95K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:49 INFO - Running setup.py (path:/tmp/pip-C8ZqYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:50 INFO - Running setup.py (path:/tmp/pip-m1Jnzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:50 INFO - Running setup.py (path:/tmp/pip-PpI4yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:50 INFO - Running setup.py (path:/tmp/pip-fmczGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:50 INFO - Running setup.py (path:/tmp/pip-DIenQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:50 INFO - Running setup.py (path:/tmp/pip-9IQHSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:50 INFO - Running setup.py (path:/tmp/pip-irldgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:50 INFO - Running setup.py (path:/tmp/pip-yeoIja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:50 INFO - Running setup.py (path:/tmp/pip-U2R706-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:50 INFO - Running setup.py (path:/tmp/pip-3wYW80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:50 INFO - Running setup.py (path:/tmp/pip-USE8cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:50 INFO - Running setup.py install for manifestparser 07:42:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:50 INFO - Running setup.py install for mozcrash 07:42:50 INFO - Running setup.py install for mozdebug 07:42:51 INFO - Running setup.py install for mozdevice 07:42:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for mozfile 07:42:51 INFO - Running setup.py install for mozhttpd 07:42:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for mozinfo 07:42:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for mozInstall 07:42:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for mozleak 07:42:51 INFO - Running setup.py install for mozlog 07:42:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for moznetwork 07:42:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:51 INFO - Running setup.py install for mozprocess 07:42:51 INFO - Running setup.py install for mozprofile 07:42:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:52 INFO - Running setup.py install for mozrunner 07:42:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:52 INFO - Running setup.py install for mozscreenshot 07:42:52 INFO - Running setup.py install for moztest 07:42:52 INFO - Running setup.py install for mozversion 07:42:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:52 INFO - Cleaning up... 07:42:52 INFO - Return code: 0 07:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:52 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:52 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 07:42:52 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 07:42:52 INFO - Using env: {'DISPLAY': ':0', 07:42:52 INFO - 'HOME': '/home/cltbld', 07:42:52 INFO - 'LANG': 'en_US.UTF-8', 07:42:52 INFO - 'LANGUAGE': 'en_US:en', 07:42:52 INFO - 'LOGNAME': 'cltbld', 07:42:52 INFO - 'MAIL': '/var/mail/cltbld', 07:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:52 INFO - 'MOZ_NO_REMOTE': '1', 07:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:52 INFO - 'NO_EM_RESTART': '1', 07:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:52 INFO - 'PWD': '/builds/slave/test', 07:42:52 INFO - 'SHELL': '/bin/bash', 07:42:52 INFO - 'SHLVL': '1', 07:42:52 INFO - 'TERM': 'linux', 07:42:52 INFO - 'TMOUT': '86400', 07:42:52 INFO - 'USER': 'cltbld', 07:42:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:52 INFO - '_': '/tools/buildbot/bin/python'} 07:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:52 INFO - Running setup.py (path:/tmp/pip-fpaMvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:52 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)) 07:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:52 INFO - Running setup.py (path:/tmp/pip-Pkjo87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:52 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)) 07:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:52 INFO - Running setup.py (path:/tmp/pip-jDyfWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:52 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)) 07:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:52 INFO - Running setup.py (path:/tmp/pip-KHlA8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:53 INFO - Running setup.py (path:/tmp/pip-qWaj0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:53 INFO - Running setup.py (path:/tmp/pip-breYE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:53 INFO - Running setup.py (path:/tmp/pip-xwT2up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:53 INFO - Running setup.py (path:/tmp/pip-lBQdsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:53 INFO - Running setup.py (path:/tmp/pip-NG0QuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:53 INFO - Running setup.py (path:/tmp/pip-N5wq4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:53 INFO - Running setup.py (path:/tmp/pip-L6TXOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:53 INFO - Running setup.py (path:/tmp/pip-aWveYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:53 INFO - Running setup.py (path:/tmp/pip-4z0jcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:53 INFO - Running setup.py (path:/tmp/pip-ncJ7uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:53 INFO - Running setup.py (path:/tmp/pip-IlMHUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:53 INFO - Running setup.py (path:/tmp/pip-_uR1C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:53 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)) 07:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:53 INFO - Running setup.py (path:/tmp/pip-ImluQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:53 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)) 07:42:53 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)) 07:42:53 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)) 07:42:53 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)) 07:42:53 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)) 07:42:53 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)) 07:42:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:55 INFO - Downloading blessings-1.6.tar.gz 07:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:55 INFO - Installing collected packages: blessings 07:42:55 INFO - Running setup.py install for blessings 07:42:56 INFO - Successfully installed blessings 07:42:56 INFO - Cleaning up... 07:42:56 INFO - Return code: 0 07:42:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:56 INFO - Reading from file tmpfile_stdout 07:42:56 INFO - Current package versions: 07:42:56 INFO - argparse == 1.2.1 07:42:56 INFO - blessings == 1.6 07:42:56 INFO - blobuploader == 1.2.4 07:42:56 INFO - docopt == 0.6.1 07:42:56 INFO - manifestparser == 1.1 07:42:56 INFO - mozInstall == 1.12 07:42:56 INFO - mozcrash == 0.17 07:42:56 INFO - mozdebug == 0.1 07:42:56 INFO - mozdevice == 0.48 07:42:56 INFO - mozfile == 1.2 07:42:56 INFO - mozhttpd == 0.7 07:42:56 INFO - mozinfo == 0.9 07:42:56 INFO - mozleak == 0.1 07:42:56 INFO - mozlog == 3.1 07:42:56 INFO - moznetwork == 0.27 07:42:56 INFO - mozprocess == 0.22 07:42:56 INFO - mozprofile == 0.28 07:42:56 INFO - mozrunner == 6.11 07:42:56 INFO - mozscreenshot == 0.1 07:42:56 INFO - mozsystemmonitor == 0.0 07:42:56 INFO - moztest == 0.7 07:42:56 INFO - mozversion == 1.4 07:42:56 INFO - psutil == 3.1.1 07:42:56 INFO - requests == 1.2.3 07:42:56 INFO - wsgiref == 0.1.2 07:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:56 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 07:42:56 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 07:42:56 INFO - Using env: {'DISPLAY': ':0', 07:42:56 INFO - 'HOME': '/home/cltbld', 07:42:56 INFO - 'LANG': 'en_US.UTF-8', 07:42:56 INFO - 'LANGUAGE': 'en_US:en', 07:42:56 INFO - 'LOGNAME': 'cltbld', 07:42:56 INFO - 'MAIL': '/var/mail/cltbld', 07:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:56 INFO - 'MOZ_NO_REMOTE': '1', 07:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:56 INFO - 'NO_EM_RESTART': '1', 07:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:56 INFO - 'PWD': '/builds/slave/test', 07:42:56 INFO - 'SHELL': '/bin/bash', 07:42:56 INFO - 'SHLVL': '1', 07:42:56 INFO - 'TERM': 'linux', 07:42:56 INFO - 'TMOUT': '86400', 07:42:56 INFO - 'USER': 'cltbld', 07:42:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:56 INFO - '_': '/tools/buildbot/bin/python'} 07:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 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)) 07:42:56 INFO - Cleaning up... 07:42:56 INFO - Return code: 0 07:42:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:56 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 07:42:56 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 07:42:56 INFO - Using env: {'DISPLAY': ':0', 07:42:56 INFO - 'HOME': '/home/cltbld', 07:42:56 INFO - 'LANG': 'en_US.UTF-8', 07:42:56 INFO - 'LANGUAGE': 'en_US:en', 07:42:56 INFO - 'LOGNAME': 'cltbld', 07:42:56 INFO - 'MAIL': '/var/mail/cltbld', 07:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:56 INFO - 'MOZ_NO_REMOTE': '1', 07:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:56 INFO - 'NO_EM_RESTART': '1', 07:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:56 INFO - 'PWD': '/builds/slave/test', 07:42:56 INFO - 'SHELL': '/bin/bash', 07:42:56 INFO - 'SHLVL': '1', 07:42:56 INFO - 'TERM': 'linux', 07:42:56 INFO - 'TMOUT': '86400', 07:42:56 INFO - 'USER': 'cltbld', 07:42:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:56 INFO - '_': '/tools/buildbot/bin/python'} 07:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:56 INFO - Downloading/unpacking jsonschema 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:58 INFO - Downloading/unpacking functools32 (from jsonschema) 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:58 INFO - warning: no files found matching '*.txt' 07:42:58 INFO - no previously-included directories found matching 'build' 07:42:58 INFO - no previously-included directories found matching 'dist' 07:42:58 INFO - no previously-included directories found matching '.git*' 07:42:58 INFO - Installing collected packages: jsonschema, functools32 07:42:58 INFO - Running setup.py install for functools32 07:42:59 INFO - warning: no files found matching '*.txt' 07:42:59 INFO - no previously-included directories found matching 'build' 07:42:59 INFO - no previously-included directories found matching 'dist' 07:42:59 INFO - no previously-included directories found matching '.git*' 07:42:59 INFO - Successfully installed jsonschema functools32 07:42:59 INFO - Cleaning up... 07:42:59 INFO - Return code: 0 07:42:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:59 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 0x7f48fc92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', '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 07:42:59 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 07:42:59 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 07:42:59 INFO - Using env: {'DISPLAY': ':0', 07:42:59 INFO - 'HOME': '/home/cltbld', 07:42:59 INFO - 'LANG': 'en_US.UTF-8', 07:42:59 INFO - 'LANGUAGE': 'en_US:en', 07:42:59 INFO - 'LOGNAME': 'cltbld', 07:42:59 INFO - 'MAIL': '/var/mail/cltbld', 07:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:59 INFO - 'MOZ_NO_REMOTE': '1', 07:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:59 INFO - 'NO_EM_RESTART': '1', 07:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:59 INFO - 'PWD': '/builds/slave/test', 07:42:59 INFO - 'SHELL': '/bin/bash', 07:42:59 INFO - 'SHLVL': '1', 07:42:59 INFO - 'TERM': 'linux', 07:42:59 INFO - 'TMOUT': '86400', 07:42:59 INFO - 'USER': 'cltbld', 07:42:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:59 INFO - '_': '/tools/buildbot/bin/python'} 07:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:59 INFO - Downloading/unpacking flake8 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:43:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:43:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:43:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:01 INFO - no previously-included directories found matching 'docs/_build' 07:43:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:43:02 INFO - Running setup.py install for pep8 07:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:02 INFO - no previously-included directories found matching 'docs/_build' 07:43:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:43:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:43:02 INFO - Cleaning up... 07:43:02 INFO - Return code: 0 07:43:02 INFO - Running post-action listener: _resource_record_post_action 07:43:02 INFO - Running post-action listener: _start_resource_monitoring 07:43:02 INFO - Starting resource monitoring. 07:43:02 INFO - ##### 07:43:02 INFO - ##### Running install step. 07:43:02 INFO - ##### 07:43:02 INFO - Running pre-action listener: _resource_record_pre_action 07:43:02 INFO - Running main action method: install 07:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:02 INFO - Reading from file tmpfile_stdout 07:43:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:02 INFO - Reading from file tmpfile_stdout 07:43:02 INFO - Output received: 07:43:02 INFO - Usage: mozinstall [options] installer 07:43:02 INFO - Options: 07:43:02 INFO - -h, --help show this help message and exit 07:43:02 INFO - -d DEST, --destination=DEST 07:43:02 INFO - Directory to install application into. [default: 07:43:02 INFO - "/builds/slave/test"] 07:43:02 INFO - --app=APP Application being installed. [default: firefox] 07:43:02 INFO - mkdir: /builds/slave/test/build/application 07:43:02 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'] 07:43:02 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 07:43:18 INFO - Reading from file tmpfile_stdout 07:43:18 INFO - Output received: 07:43:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:43:18 INFO - Running post-action listener: _resource_record_post_action 07:43:18 INFO - ##### 07:43:18 INFO - ##### Running run-tests step. 07:43:18 INFO - ##### 07:43:18 INFO - Running pre-action listener: _resource_record_pre_action 07:43:18 INFO - Running main action method: run_tests 07:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:18 INFO - Python 2.7.3 07:43:18 INFO - Return code: 0 07:43:18 INFO - grabbing minidump binary from tooltool 07:43: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')]} 07:43:18 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 0x22b9640>, '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 0x22ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ba9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:18 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 07:43:18 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 07:43:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:18 INFO - Return code: 0 07:43:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:43:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:43:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:43:19 INFO - Return code: 0 07:43:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:43:19 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:43:19 INFO - Using env: {'DISPLAY': ':0', 07:43:19 INFO - 'HOME': '/home/cltbld', 07:43:19 INFO - 'LANG': 'en_US.UTF-8', 07:43:19 INFO - 'LANGUAGE': 'en_US:en', 07:43:19 INFO - 'LOGNAME': 'cltbld', 07:43:19 INFO - 'MAIL': '/var/mail/cltbld', 07:43:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:19 INFO - 'MOZ_NO_REMOTE': '1', 07:43:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:19 INFO - 'NO_EM_RESTART': '1', 07:43:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:19 INFO - 'PWD': '/builds/slave/test', 07:43:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:19 INFO - 'SHELL': '/bin/bash', 07:43:19 INFO - 'SHLVL': '1', 07:43:19 INFO - 'TERM': 'linux', 07:43:19 INFO - 'TMOUT': '86400', 07:43:19 INFO - 'USER': 'cltbld', 07:43:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525', 07:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:19 INFO - '_': '/tools/buildbot/bin/python'} 07:43:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:43:19 INFO - mozversion application_buildid: 20160411065021 07:43:19 INFO - mozversion application_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 07:43:19 INFO - mozversion application_display_name: Nightly 07:43:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:19 INFO - mozversion application_name: Firefox 07:43:19 INFO - mozversion application_remotingname: firefox 07:43:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:43:19 INFO - mozversion application_vendor: Mozilla 07:43:19 INFO - mozversion application_version: 48.0a1 07:43:19 INFO - mozversion platform_buildid: 20160411065021 07:43:19 INFO - mozversion platform_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 07:43:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:43:19 INFO - mozversion platform_version: 48.0a1 07:43:19 INFO - using testdate: 1460385799 07:43:19 INFO - actual date: 1460385799 07:43:19 INFO - starting webserver on 'localhost:41055' 07:43:19 INFO - SUITE-START | Running 2 tests 07:43:19 INFO - TEST-START | dromaeo_css 07:43:19 INFO - operating with platform_type : linux_ 07:43:19 INFO - Initialising browser for dromaeo_css test... 07:43:19 INFO - TEST-INFO | started process 18395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVtFeLu/profile http://localhost:41055/getInfo.html) 07:43:23 INFO - PROCESS | 18395 | 07:43:23 INFO - PROCESS | 18395 | (process:18461): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:43:23 INFO - PROCESS | 18395 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:43:23 INFO - PROCESS | 18395 | __metrics Screen width/height:1600/1200 07:43:23 INFO - PROCESS | 18395 | colorDepth:24 07:43:23 INFO - PROCESS | 18395 | Browser inner width/height: 1024/697 07:43:23 INFO - PROCESS | 18395 | __metrics 07:43:24 ERROR - PROCESS | 18395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 07:43:25 INFO - TEST-INFO | 18395: exit 0 07:43:25 INFO - Browser initialized. 07:43:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:25 INFO - TEST-INFO | started process 18512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVtFeLu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:27 INFO - PROCESS | 18512 | 07:43:27 INFO - PROCESS | 18512 | (process:18571): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:43:37 INFO - PROCESS | 18512 | RSS: Main: 164397056 07:43:37 INFO - PROCESS | 18512 | 07:44:27 INFO - PROCESS | 18512 | 1460385867092 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] 07:46:38 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41055/tests/dromaeo/cssquery-ext.html) 07:46:39 INFO - PROCESS | 18512 | RSS: Main: 168726528 07:46:39 INFO - PROCESS | 18512 | 07:49:41 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-ext.html (next: http://localhost:41055/tests/dromaeo/cssquery-jquery.html) 07:49:42 INFO - PROCESS | 18512 | RSS: Main: 165236736 07:49:42 INFO - PROCESS | 18512 | 07:52:44 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41055/tests/dromaeo/cssquery-mootools.html) 07:52:45 INFO - PROCESS | 18512 | RSS: Main: 166907904 07:52:45 INFO - PROCESS | 18512 | 07:55:46 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41055/tests/dromaeo/cssquery-prototype.html) 07:55:47 INFO - PROCESS | 18512 | RSS: Main: 164225024 07:55:47 INFO - PROCESS | 18512 | 07:58:50 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41055/tests/dromaeo/cssquery-yui.html) 07:58:50 INFO - PROCESS | 18512 | RSS: Main: 165941248 07:58:50 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:41055/tests/dromaeo/cssquery-yui.html (next: http://localhost:41055/tests/dromaeo/cssquery-dojo.html) 08:01:53 INFO - PROCESS | 18512 | RSS: Main: 167964672 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | __start_tp_report 08:01:53 INFO - PROCESS | 18512 | _x_x_mozilla_page_load 08:01:53 INFO - PROCESS | 18512 | _x_x_mozilla_page_load_details 08:01:53 INFO - PROCESS | 18512 | |i|pagename|runs| 08:01:53 INFO - PROCESS | 18512 | |0;dojo.html;2659.5212861684895;2711.0646826844745;2743.2456074579486;2753.876075576599;2754.903578374757;4788.281757736337;4792.760361981896;4808.6153107751425;4824.807007719692;4901.901961960759;4726.85819425417;4750.857474275768;4798.328234047236;4801.495842936485;4870.829520966767;4416.337549367605;4477.059817438342;4533.977330113345;4538.546145385468;4572.519885412017;611.3082132657986;4298;4387.2541667916375;4406.71356361837;4439.778011099448;4364.388985542027;4365.890852728676;4369.672274579403;4388.451443569554;4457.977710111429;4359.849522907902;4364.41080454141;4372.715773474714;4378.233809083429;4410.3825464435;4328.935065974013;4352.7823608819745;4357.520672725997;4399.186150562125;4414.293713005904;4696.225122854725;4707.552782485658;4708.858734237979;4710.576048155683;4765.809367625291;5117.283580298761;5138.177891537373;5141.665791723563;5147;5177.974110129425;5079.288899554065;5121.334226550562;5160.767765450564;5195.480451954774;5211.817586384458;4766.928496072562;4778.187708089633;4784.952150478485;4837;4838.637102217348;5250.291210686585;5253.3958594761325;5259.263703081571;5260.71066091361;5268.288781014514;4948.208286674115;4998.775055122528;5044.369453818273;5067.721275329818;5076.593872490192;5108.772069785629;5114.846554603368;5121.718305493159;5138.58891288696;5147.433782283946;5061.44324124346;5065.924011139836;5072.949270507322;5074.441811400743;5080.390353157644;4946.035523073038;5082.161443361878;5100.923486147711;5155.32980712505;5170.302009228782;4220.7467551946365;4255.234057869613;4262.25410553152;4273.978630106892;4295.5489673583825;3705.629437056327;3765.058735316171;3782.924341513154;3783.791891445942;3804.771713697187;4392.868213953587;4435.82256709728;4488.730676159441;4504.1216962692615;4537.659675524349;5131.409887862869;5161.200013997836;5193.221016847428;5203;5240.868978275574;4379.759113248802;4550.089982003613;4554.066416384633;4559.908801824011;4602.05657840142;4583.702059366131;4610;4623.052274283764;4660.673752837269;4662.090892276042;4739.763011849463;4776.140294746979;4834.7824347903725;4838.661293709407;4874.53691899269;5037.219231019198;5044.041632089891;5104.1578139606545;5107.744612769421;5159.329287192641;4857.611391088633;4888.828890988798;4889.3888263967;4891.51084891508;4927.28554359623;5092.287079808756;5094.5669618082875;5096.617753668415;5096.745162741922;5151.381834179922;5004.949950500449;5146.382434107931;5176.327077479904;5178.611604129781;5230.476952304739;4954.355933728592;4962.6774259673;4975.452700203047;4991.925121123113;5019.949800501949;4985.376827896513;4986.102501549756;4987.077390682735;4990.051890141007;5027.673201241908;4849.733264670336;4870.488598697086;4910.92633610489;4944.554990050912;4968.130577149057;5020.196768517019;5033.421156567042;5040.395152581714;5048.72232027242;5069.391672999263;4874.683145595525;4877.585405240594;4885.560299573055;4914.459409465027;4958.479359667183 08:01:53 INFO - PROCESS | 18512 | |1;ext.html;570.3611954610836;600.2646757721791;616.6053725615604;616.8642898562316;643.4884267007728;31740.365192696132;32341.353172936528;32494.512582311254;32552.348953020926;32710.345793084125;32834;33062.834685826594;33102.50346244808;33442;33450.66549334512;4032.798360081999;4046.514418269812;4062.756234625917;4065.227606754722;4174.66602671787;7416.666250018762;7639.350655194287;7646.923530764677;7659.195784442637;7660.387169026464;7612.238776122399;7635.121960974503;7657.272559106904;7689.077310722693;7733.7679869604;7645.579493127876;7668.846623067508;7715.72994945177;7719.073711154698;7728.845423091563;7543.73596924105;7627.313541781211;7650.464467487278;7657.387409007321;7659.195784442609;29836.701632983826;33340.49989250163;33720.32559348799;33853.661463385295;33944.15139621504;2997.5353820157693;3021.8035827671133;3043.406535725512;3133.937321253562;3599.1182160370613;23745.643815342784;24100.87949560241;24235.878820605783;24709.258722238363;24947.750522494724;3136.2159460134967;3284.835758212104;3314.784539004957;3335.816530090844;3369.427197376452;137857;138708.30645846808;139001.99999999898;139089;139507.30246348702;30358.241043974078;30556.236094097825;31898.681013189573;32672.183195420304;32815;30885.691143088283;30943.0717078488;30947.535786963213;31035.224119396746;31201.8439907799;12466.563670271496;12717.10980231375;12775.425105870258;12791.104622676323;12819.16675416095;10299.330543514647;10379.792404152025;10390.948045259725;10402.895971040343;10475.738106547245;7968.402369822286;7984.081830589556;8057.556834374049;8100.3519718422385;8130.674773009014;3157.636871759731;3200.3439294944483;3254.4792833146585;3266.4773636218565;3290.4570745826672;889.902110767815;918.7519369770125;957.9042095790504;981.0434826044692;1037.3775734559204;27371;27854.16437506878;28010.159695209175;28117;28212.85893570519;965.6571916969515;975.6048800235916;996.5963784667222;997.3068717241592;1061.3950048472298;14513.709725805425;15002.374109708859;15028.323725432381;15109;15168.772468412983;309201;312927;314504;314701;316259;46362.30456543154;47050.5294947053;47104.64476776148;47233.76383118131;47306;1224.8285240066398;1228.3673907937418;1232.5254776910954;1252.3049707412292;1277.1506947879557;26046.08838690637;27164;27259.59110613382;27447.86276068607;27669.169924902286;40942;41210.38184427296;41430;41457;41554.58445415507;269520;269727;271320;272045;272475;24427.51144977126;25002.124925627515;37153.442698359;38343.808280958416;38545.22909541737;37830.243395131394;38188.2362352757;38688.41967370548;38994.220115598095;39165.216695666495;32615.021549353558;33466.33067338688;33735.32529349448;33890.66109338974;34088.318233635684;32256;33057.33885322328;33243;33433.49849752207;33574.32851343008;33127;33579.83210083934;37972.430413544374;39493.60506394899;39728.60271397249;28926.566101508914;30464.543031854984;31015.379692405575;31239.219019524695;31243.375132496767;24137.879310603334;24618.138365157134;24712.876435617705;24976.250712478653;25091.87454062718 08:01:53 INFO - PROCESS | 18512 | |2;jquery.html;366.26563739701896;369.93711069118257;380.66501478698723;382.1783166192685;391.3054328566792;15753.369865205392;16630.916845415788;17542.473725788215;17674.381396651137;17722.29110835565;15965.361385544564;16239.837601624009;16884.493465196032;16989.745153822703;17015.57461063474;4943.1596628573225;5078.746062696869;5121.871953201163;5135.255387968742;5135.871603209912;3647.4893514907935;5048.495150484959;5355;5603.719814009303;5635.520980716644;5558.249636299089;5561.249231353756;5587.469190426923;5607.971960140214;5613.410591887854;5510;5567.972160139194;5701.2018317435595;5719.399463056381;5740.569457290678;4996.7501624918605;5019.548240658358;5030.471800460972;5031.7987280509105;5036.244563315496;18504.814951850443;18672.719909201373;18971.620567588572;19045.904770476198;19234;1948.8538359623085;2001.9184223212985;2014.3252010576475;2050.5046475445797;2058.495668561197;12875.227486350848;13227.86772132276;13472.25902575358;13511;13690.863091369058;1679;1751.5183324585714;1771.3268957796083;1836.4215272189351;1858.721191821224;67258.32741672569;68312.6584367075;69411.65294173548;69480.3051969484;70121.64939175271;9028.322875784343;9092.090790920987;9277.257819374434;9365.15713585767;9546.522673866279;12749.043821713409;12777.808332875014;12850.48598056086;12891.806622900664;12909.483620655068;6840;7059.188193357727;7148.678309476086;7213.963930180315;7229.638518074181;6737.056812046318;6848.863022739617;6862.622555759382;6903.447724182053;7048.224695283515;5814.59297849155;5904.9704751475965;5911.527077833849;5930.644161350247;6019.976603977334;1618.4659062509343;1689.5860514174105;1764.8323409276097;1766.2316892151955;1817.7636907202243;872.3283072034498;958.9041095890494;968.9273304502191;980.0150848397458;1023.8566600675912;16352.672946541003;16635.41776037833;16781.909175903525;17044.48866534006;17350.13249337528;865.1737590600961;867.3624885708999;901.724973882972;903.7921278106072;947.9526023698787;9429.15137637616;9636.46999415039;9773.047456428954;9778.31551791382;9821.754456138653;121783;407177;409076;418017;419063;63187.36812631815;63766.36233637697;64588;65030.674846625465;66931.66534167298;918.9035151309016;940.9388389754644;958.750724811554;959.7936443664506;960.4045491795132;14777.630559236106;14956.042474801128;15087.547373578811;15175.848241517886;15444.30500627452;30849.845750771103;31142.844285778425;32525.34949301048;32551.18622034468;32969.835150824096;42902;43095.13809723851;43390.566094338654;43394;43419.56580434282;7203.387712044535;7317.707291708272;7380.704771809067;7592.468527203043;7730.342920851791;10815.35107893529;10843.67468975932;11158.49786759614;11443.713907152387;11639.127065469955;9277.16505514507;9645.37305075168;9743.951280243553;10331.638392656221;10401.53193106297;9503.619855205714;9530.714078577654;10052.84920726175;10365.429901355497;10517.263791534519;9853.719016527806;10226.488675566043;10522.684319470429;10528.473576321307;10532.473376331305;7432.21961694036;7511.661975211238;7613.695452182073;7745.7676269712;7889.053313602404;10292.948535257276;10450.843237351293;10620.20348473852;10638.468076596295;10663.253572249869 08:01:53 INFO - PROCESS | 18512 | |3;mootools.html;1478.9408423663053;1492.6641505661225;1636.1410259613701;1792.2293413832047;1806.421944977607;6925.203601585819;7385.593792341419;7419.183889772121;7648.541087534752;7661.3487853532515;7504.174540800507;7506.849863002737;7534.0582427196605;7577.128630207528;7591;2159.373781603337;2204.261572373257;2207.4040009197506;2212.6459766437374;2216.235398787424;2208.591410589046;2209.5470428562185;2247.5729611373868;2255.9210427635035;2259.2318611672026;2209;2243.461569223391;2245.8989345479495;2251.3583628665833;2278.3734473019886;2202.537467131904;2216.4791274050585;2223.5330580578097;2227.543353612514;2229.643257078868;2157.1155826111217;2186.4533866533366;2192.7478339990944;2193.2762188477764;2200.966985495219;7616.238376162395;7646.885296720554;7671.923280767177;7705.730299439493;7707.614619269014;4539.228331183706;4662.790174442158;4673.95326046742;4699.530046995307;4700.882477938079;2731.644886164806;2915.3440475892967;2966.332575170591;2971;2976.151796737941;908.0783005249676;921.9907800922039;945.7966537194536;947.6067432015706;950.083169741203;10374.63688770897;10421.68734937953;10430.739231519197;10431.113355364803;10439.269251152422;4071.4096456013713;4086.734362266443;4258.5954334338185;4260.382244574519;4280.636145927569;8920.063393343735;8920.73237802867;8921.330900182382;8926.419782714103;8941.105889411007;4693.413323334583;4711;4720.0559888022535;4726.220173671374;4730.787114579852;3700.0564855961557;4171.8957026074595;4282.443282373271;4306.1172459645695;4311.978440107842;3588.138846676779;3594.4248920172645;3679.7240206984584;3683.6316368363487;3725.6088110748524;1204.6205445284706;1215.9392030398444;1222.896053835416;1228.6129869091208;1235.4749231576543;979.9755006124904;1013.640157744005;1015.6902144845893;1095.7534554725123;1255.1590434408968;7143.678534465961;7290.927090729131;7344.632768361561;7354.411647068222;7393.630318484054;431.34866351808995;440.67830483746405;442.4535698412458;445.2097526889797;446.01875873079354;5452.400235974119;5484.122540393598;5498.257735205696;5541.501264886179;5670.801521946794;9333.113354231336;9667.323287369958;9693.757656058655;9701.029897010243;9701.757456063513;9577.473238971785;9630.951845240868;9635.614575416905;9675.661351852652;9701.563429645683;7316.707331706779;7388.963055184797;7405.851882962311;7410.184879663233;7421.591812450259;7184.6048467334795;7234.6020968847215;7352.96323518379;7353.522021068614;7362.852742945004;8679.26226270774;8819.823603528022;8856.291496680122;8885.600147993226;9064;8803.339749518684;8967.730968070968;9065.048169942062;9100.544972751468;9166.862497062682;6154.538409619386;6577.440917522064;6789.355011273921;6952.443804495527;7026.473014524034;7286.453515986216;7346.96326518364;7354.264573542603;7384.963075184804;7399.075115610549;6394.488440924808;6744.763933262312;6771.28901465339;6806.18325800907;6913.032175495535;6631.900521492278;6633.270340262664;6665.100211471389;6762.357576030269;6770.1537307836525;6968.616726080114;7153.535020223877;7159.105111861018;7179.7128114876905;7198.928010719826;6487.610743355413;6489.318621544669;6524.282328943717;6525.2169739631545;6557.114789503356;6319.178506794087;6365.522585806176;6405.0392441132335;6424.550281480251;6426.228852537725 08:01:53 INFO - PROCESS | 18512 | |4;prototype.html;297.64580149621946;298.2781668362563;301.49198600358386;301.7540704325973;306.82357644354494;5194.376674799025;5269.710165940872;5359.856057576966;5377.973110134453;5392.137258038714;5179.792808287664;5234.476552344764;5268.130758424865;5269.262303277535;5271.341082364705;3913.8238779255003;4049.8785036448953;4072.5927407259333;4155.189738001091;4162.542120366757;4130.153318569686;4155.854545090922;4162.97918510407;4175.54069052404;4188.371744238359;4120;4133.1320422711115;4136.565660605638;4156.127213285214;4168.583141685823;4050.8784736457956;4115.382692596135;4127.2570937231285;4149.33610622299;4151.356539736315;3593.6047034826147;3612.133088058847;3618.4029635110173;3621.040424287566;3661;5054.241863720435;5066.138756411419;5071.492850714936;5076.923846142311;5082.720450375228;4416.447944006999;4752.5485078917445;4789.449213340476;4801.231802911518;4803.351547541072;5638.774449022034;5642.463965923231;5646.604737668365;5654.547636189095;5660.179274005287;3839.884803455901;3850.84596616135;3876.1472476055505;3885.61143885612;3887.961120388788;5808.12878068289;5884.08796636522;5933.940660593382;5963.105534169866;5994.790182343597;3989.3018721723583;4001.6794457828846;4005;4012.29784787661;4019.8191081401405;4052.8176232069627;4064.552899181088;4067.2882245607493;4068.4304197412384;4074.572169922175;4672.322513235562;4690.108879312919;4705.1765940960195;4711.869151403638;4720.244760838249;5487.368952570426;5605;5622.522085622686;5630.831075067755;5649.237352957381;1387.67389663429;1399.846016938136;1409.6405416618697;1410.985890141106;1411.3225651687249;864.446754077391;904.5793705926776;920.374145580998;948.4925564822787;949.0699114867468;4881.389826271716;5013.649044566918;5046.167382381939;5049.84850454487;5072.036313100499;5785.623934444332;5835.124731290341;5870.178175055496;5877.265341832271;5880.647161170344;4847.151748444078;5015.1975683890405;5016.194170098762;5030.270610761419;5049.671771334852;3090.8300043497825;3091.27355071558;3093.1030001299823;3121.8282994435526;3147.2603938074535;5524.779008839681;5534.391216966131;5535.059039963216;5543.805966791143;5566.916496252559;5756.539476841843;6028.758849646053;6085.269767627825;6090.482309003784;6104.816855494253;5530.253415788898;5546.75039623226;5551.500364967173;5574.526165275915;5584.888302233932;5712.971435142797;5841.912371314349;5846.503047241032;5847.26909136358;5854.443827836349;5771.682557459212;5801.477866991991;5808.651480911159;5823.242978412949;5829.15477255804;5512.39363669988;5542.307211598551;5580.302462192226;5587.1339942309005;5602.722407391559;3821.159344944108;3962.54430740457;3996.340603800457;4021.1248956995887;4046.5548789632526;5835.620684655484;5847.298324200953;5852.268466441695;5877.882442351043;5883.294004719461;5583.469570390806;5632.408597097409;5633.310006997803;5649.548036157015;5699.316082070178;5536.169574563686;5641.605087643826;5649.689267090185;5660.971695141498;5664.5751568631695;5261.868453288698;5525.309336332958;5547.861303467445;5550.306211723535;5576.972115139399;5450.563954883679;5624.268845050281;5634.295713035871;5671.291088613923;5681.204631351531;5455.399906010415;5502.5597952164535;5510.752016159363;5513.751881165277;5530.695811730394 08:01:53 INFO - PROCESS | 18512 | |5;yui.html;774.3921021997731;775.511427800486;776.2315307845231;792.2236208515652;801.7674874286457;12405.937970310148;12655.873441265585;12701.555445559407;12709.618711438672;12761.872381276196;11859;12070.094742894275;12119.636410907664;13408.731825363511;13438.462461501553;807.2573232625969;810.1574362662824;811.7037281392309;812.6180695073306;812.9715459958887;799.564237490569;801.7995501124719;803.4496369986549;804.7143264141233;810.1938571121713;854.0178794386443;854.6196942360652;855.0423525651279;855.9743207703748;859.2138193552892;845.9069502354736;846.4032856835915;852.8848605438279;853.957302134897;855.4738835616082;624.5908929651085;624.6158612453354;624.9906251406233;626.5551458464496;628.7642134199675;11924.821127683092;11971.64085077449;11999.94000030003;12004.339761313124;12671.17637353569;11855.822162667568;12030.4586293617;12034.939825300906;12142.392880356036;12378.195417297848;9529.142377186086;9658.855117173249;9765.16996055329;9804.215662746963;9922.9503852481;3307.7353811695007;3316.8839090631714;3353.899383018513;3363.209645733251;3395.6604339566093;40477.79761101205;43477.34783978243;43788.562114378765;43794;48691.26963095556;9370.250379969586;9526.428414295164;9590.904090959;9653.420794752337;9768.706938791847;15115.470958516398;15123.924380378028;15132.697346053237;15218;15253.237338133049;6968.547044442196;6995.370416662423;7034.859302813915;7054.6472676365975;7089.539179953286;3975.423563583322;3991.3214753491975;4069.409935559327;4069.4709687740406;4072.2873497137884;2791.288221503504;2851.8859245630356;2875.2668069642527;2878.668953070424;2891.6530016397746;524.0697761473339;530.3635637235333;534.8796520782793;542.7937383794211;542.8154427494592;540.6972095626462;611.7457170327358;654.4862283107833;672.7275453441364;678.935501127402;7621.771346859603;7830.2952734254195;7948.642311095899;8012.959935200287;8153.347732181412;601.7412512619528;635.7234602947733;638.6966191059303;659.8548319369731;666.8099591616366;3794.848206071726;3946.131850992777;3959.247742928892;4082.6121518455698;4092.07928216149;48363.75818120887;49023;49631.25553116706;49803.25295120576;49980.750096249285;43720.78139609282;44164.337534937;44476.55523444724;44550.108997819865;44729.32906006413;35173.64826351704;39207.21585568273;40161;41605.791971040555;42826.35760463658;7829.491083079582;7901;7914.722984695508;7918.208179182036;8174.591270436335;29126.56310155307;29362;29425.70574294315;30241.395172096876;30307.393852122394;37034.259314814095;37117.81441092777;37306.6269337314;37518.87443376703;38057.238855223295;9968.352057116264;10511.94744026275;10644.680659580225;10711.464426778786;11091.611793587186;10634;10758.031777140095;11294.378809165246;11754.70613234676;11757.76484470323;11197.60808371703;11218.220076742171;11282.21024528308;11497.19519633651;11534.307941523535;10904;11092.556297748;11177;11210.66368008961;11248.831267531157;10979.971387696734;11047.502862371373;11187.552497900318;11277.32336059839;11288.717782055513;8858.468491890508;8903.599338029933;9108.970199171155;9227.677031303872;9435.52822358893;8952.820943581222;9005.774855628662;9033.412828166149;9144.862827057466;9378.498607987325 08:01:53 INFO - PROCESS | 18512 | __end_tp_report 08:01:53 INFO - PROCESS | 18512 | __start_cc_report 08:01:53 INFO - PROCESS | 18512 | _x_x_mozilla_cycle_collect,371 08:01:53 INFO - PROCESS | 18512 | __end_cc_report 08:01:53 INFO - PROCESS | 18512 | __startTimestamp1460386913545__endTimestamp 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | ------- Summary: start ------- 08:01:53 INFO - PROCESS | 18512 | Number of tests: 6 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#0] dojo.html Cycles:165 Average:4718.90 Median:4877.59 stddev:588.52 (12.1%) stddev-sans-first:567.72 08:01:53 INFO - PROCESS | 18512 | Values: 2659.5 2711.1 2743.2 2753.9 2754.9 4788.3 4792.8 4808.6 4824.8 4901.9 4726.9 4750.9 4798.3 4801.5 4870.8 4416.3 4477.1 4534.0 4538.5 4572.5 611.3 4298.0 4387.3 4406.7 4439.8 4364.4 4365.9 4369.7 4388.5 4458.0 4359.8 4364.4 4372.7 4378.2 4410.4 4328.9 4352.8 4357.5 4399.2 4414.3 4696.2 4707.6 4708.9 4710.6 4765.8 5117.3 5138.2 5141.7 5147.0 5178.0 5079.3 5121.3 5160.8 5195.5 5211.8 4766.9 4778.2 4785.0 4837.0 4838.6 5250.3 5253.4 5259.3 5260.7 5268.3 4948.2 4998.8 5044.4 5067.7 5076.6 5108.8 5114.8 5121.7 5138.6 5147.4 5061.4 5065.9 5072.9 5074.4 5080.4 4946.0 5082.2 5100.9 5155.3 5170.3 4220.7 4255.2 4262.3 4274.0 4295.5 3705.6 3765.1 3782.9 3783.8 3804.8 4392.9 4435.8 4488.7 4504.1 4537.7 5131.4 5161.2 5193.2 5203.0 5240.9 4379.8 4550.1 4554.1 4559.9 4602.1 4583.7 4610.0 4623.1 4660.7 4662.1 4739.8 4776.1 4834.8 4838.7 4874.5 5037.2 5044.0 5104.2 5107.7 5159.3 4857.6 4888.8 4889.4 4891.5 4927.3 5092.3 5094.6 5096.6 5096.7 5151.4 5004.9 5146.4 5176.3 5178.6 5230.5 4954.4 4962.7 4975.5 4991.9 5019.9 4985.4 4986.1 4987.1 4990.1 5027.7 4849.7 4870.5 4910.9 4944.6 4968.1 5020.2 5033.4 5040.4 5048.7 5069.4 4874.7 4877.6 4885.6 4914.5 4958.5 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#1] ext.html Cycles:180 Average:38236.28 Median:32824.50 stddev:66474.31 (202.5%) stddev-sans-first:66600.63 08:01:53 INFO - PROCESS | 18512 | Values: 570.4 600.3 616.6 616.9 643.5 31740.4 32341.4 32494.5 32552.3 32710.3 32834.0 33062.8 33102.5 33442.0 33450.7 4032.8 4046.5 4062.8 4065.2 4174.7 7416.7 7639.4 7646.9 7659.2 7660.4 7612.2 7635.1 7657.3 7689.1 7733.8 7645.6 7668.8 7715.7 7719.1 7728.8 7543.7 7627.3 7650.5 7657.4 7659.2 29836.7 33340.5 33720.3 33853.7 33944.2 2997.5 3021.8 3043.4 3133.9 3599.1 23745.6 24100.9 24235.9 24709.3 24947.8 3136.2 3284.8 3314.8 3335.8 3369.4 137857.0 138708.3 139002.0 139089.0 139507.3 30358.2 30556.2 31898.7 32672.2 32815.0 30885.7 30943.1 30947.5 31035.2 31201.8 12466.6 12717.1 12775.4 12791.1 12819.2 10299.3 10379.8 10390.9 10402.9 10475.7 7968.4 7984.1 8057.6 8100.4 8130.7 3157.6 3200.3 3254.5 3266.5 3290.5 889.9 918.8 957.9 981.0 1037.4 27371.0 27854.2 28010.2 28117.0 28212.9 965.7 975.6 996.6 997.3 1061.4 14513.7 15002.4 15028.3 15109.0 15168.8 309201.0 312927.0 314504.0 314701.0 316259.0 46362.3 47050.5 47104.6 47233.8 47306.0 1224.8 1228.4 1232.5 1252.3 1277.2 26046.1 27164.0 27259.6 27447.9 27669.2 40942.0 41210.4 41430.0 41457.0 41554.6 269520.0 269727.0 271320.0 272045.0 272475.0 24427.5 25002.1 37153.4 38343.8 38545.2 37830.2 38188.2 38688.4 38994.2 39165.2 32615.0 33466.3 33735.3 33890.7 34088.3 32256.0 33057.3 33243.0 33433.5 33574.3 33127.0 33579.8 37972.4 39493.6 39728.6 28926.6 30464.5 31015.4 31239.2 31243.4 24137.9 24618.1 24712.9 24976.3 25091.9 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#2] jquery.html Cycles:180 Average:22653.48 Median:24181.36 stddev:61617.49 (254.8%) stddev-sans-first:61767.62 08:01:53 INFO - PROCESS | 18512 | Values: 366.3 369.9 380.7 382.2 391.3 15753.4 16630.9 17542.5 17674.4 17722.3 15965.4 16239.8 16884.5 16989.7 17015.6 4943.2 5078.7 5121.9 5135.3 5135.9 3647.5 5048.5 5355.0 5603.7 5635.5 5558.2 5561.2 5587.5 5608.0 5613.4 5510.0 5568.0 5701.2 5719.4 5740.6 4996.8 5019.5 5030.5 5031.8 5036.2 18504.8 18672.7 18971.6 19045.9 19234.0 1948.9 2001.9 2014.3 2050.5 2058.5 12875.2 13227.9 13472.3 13511.0 13690.9 1679.0 1751.5 1771.3 1836.4 1858.7 67258.3 68312.7 69411.7 69480.3 70121.6 9028.3 9092.1 9277.3 9365.2 9546.5 12749.0 12777.8 12850.5 12891.8 12909.5 6840.0 7059.2 7148.7 7214.0 7229.6 6737.1 6848.9 6862.6 6903.4 7048.2 5814.6 5905.0 5911.5 5930.6 6020.0 1618.5 1689.6 1764.8 1766.2 1817.8 872.3 958.9 968.9 980.0 1023.9 16352.7 16635.4 16781.9 17044.5 17350.1 865.2 867.4 901.7 903.8 948.0 9429.2 9636.5 9773.0 9778.3 9821.8 121783.0 407177.0 409076.0 418017.0 419063.0 63187.4 63766.4 64588.0 65030.7 66931.7 918.9 940.9 958.8 959.8 960.4 14777.6 14956.0 15087.5 15175.8 15444.3 30849.8 31142.8 32525.3 32551.2 32969.8 42902.0 43095.1 43390.6 43394.0 43419.6 7203.4 7317.7 7380.7 7592.5 7730.3 10815.4 10843.7 11158.5 11443.7 11639.1 9277.2 9645.4 9744.0 10331.6 10401.5 9503.6 9530.7 10052.8 10365.4 10517.3 9853.7 10226.5 10522.7 10528.5 10532.5 7432.2 7511.7 7613.7 7745.8 7889.1 10292.9 10450.8 10620.2 10638.5 10663.3 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#3] mootools.html Cycles:180 Average:5411.79 Median:6456.92 stddev:2879.46 (44.6%) stddev-sans-first:2872.37 08:01:53 INFO - PROCESS | 18512 | Values: 1478.9 1492.7 1636.1 1792.2 1806.4 6925.2 7385.6 7419.2 7648.5 7661.3 7504.2 7506.8 7534.1 7577.1 7591.0 2159.4 2204.3 2207.4 2212.6 2216.2 2208.6 2209.5 2247.6 2255.9 2259.2 2209.0 2243.5 2245.9 2251.4 2278.4 2202.5 2216.5 2223.5 2227.5 2229.6 2157.1 2186.5 2192.7 2193.3 2201.0 7616.2 7646.9 7671.9 7705.7 7707.6 4539.2 4662.8 4674.0 4699.5 4700.9 2731.6 2915.3 2966.3 2971.0 2976.2 908.1 922.0 945.8 947.6 950.1 10374.6 10421.7 10430.7 10431.1 10439.3 4071.4 4086.7 4258.6 4260.4 4280.6 8920.1 8920.7 8921.3 8926.4 8941.1 4693.4 4711.0 4720.1 4726.2 4730.8 3700.1 4171.9 4282.4 4306.1 4312.0 3588.1 3594.4 3679.7 3683.6 3725.6 1204.6 1215.9 1222.9 1228.6 1235.5 980.0 1013.6 1015.7 1095.8 1255.2 7143.7 7290.9 7344.6 7354.4 7393.6 431.3 440.7 442.5 445.2 446.0 5452.4 5484.1 5498.3 5541.5 5670.8 9333.1 9667.3 9693.8 9701.0 9701.8 9577.5 9631.0 9635.6 9675.7 9701.6 7316.7 7389.0 7405.9 7410.2 7421.6 7184.6 7234.6 7353.0 7353.5 7362.9 8679.3 8819.8 8856.3 8885.6 9064.0 8803.3 8967.7 9065.0 9100.5 9166.9 6154.5 6577.4 6789.4 6952.4 7026.5 7286.5 7347.0 7354.3 7385.0 7399.1 6394.5 6744.8 6771.3 6806.2 6913.0 6631.9 6633.3 6665.1 6762.4 6770.2 6968.6 7153.5 7159.1 7179.7 7198.9 6487.6 6489.3 6524.3 6525.2 6557.1 6319.2 6365.5 6405.0 6424.6 6426.2 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#4] prototype.html Cycles:180 Average:4662.84 Median:5269.49 stddev:1386.58 (26.3%) stddev-sans-first:1351.21 08:01:53 INFO - PROCESS | 18512 | Values: 297.6 298.3 301.5 301.8 306.8 5194.4 5269.7 5359.9 5378.0 5392.1 5179.8 5234.5 5268.1 5269.3 5271.3 3913.8 4049.9 4072.6 4155.2 4162.5 4130.2 4155.9 4163.0 4175.5 4188.4 4120.0 4133.1 4136.6 4156.1 4168.6 4050.9 4115.4 4127.3 4149.3 4151.4 3593.6 3612.1 3618.4 3621.0 3661.0 5054.2 5066.1 5071.5 5076.9 5082.7 4416.4 4752.5 4789.4 4801.2 4803.4 5638.8 5642.5 5646.6 5654.5 5660.2 3839.9 3850.8 3876.1 3885.6 3888.0 5808.1 5884.1 5933.9 5963.1 5994.8 3989.3 4001.7 4005.0 4012.3 4019.8 4052.8 4064.6 4067.3 4068.4 4074.6 4672.3 4690.1 4705.2 4711.9 4720.2 5487.4 5605.0 5622.5 5630.8 5649.2 1387.7 1399.8 1409.6 1411.0 1411.3 864.4 904.6 920.4 948.5 949.1 4881.4 5013.6 5046.2 5049.8 5072.0 5785.6 5835.1 5870.2 5877.3 5880.6 4847.2 5015.2 5016.2 5030.3 5049.7 3090.8 3091.3 3093.1 3121.8 3147.3 5524.8 5534.4 5535.1 5543.8 5566.9 5756.5 6028.8 6085.3 6090.5 6104.8 5530.3 5546.8 5551.5 5574.5 5584.9 5713.0 5841.9 5846.5 5847.3 5854.4 5771.7 5801.5 5808.7 5823.2 5829.2 5512.4 5542.3 5580.3 5587.1 5602.7 3821.2 3962.5 3996.3 4021.1 4046.6 5835.6 5847.3 5852.3 5877.9 5883.3 5583.5 5632.4 5633.3 5649.5 5699.3 5536.2 5641.6 5649.7 5661.0 5664.6 5261.9 5525.3 5547.9 5550.3 5577.0 5450.6 5624.3 5634.3 5671.3 5681.2 5455.4 5502.6 5510.8 5513.8 5530.7 08:01:53 INFO - PROCESS | 18512 | 08:01:53 INFO - PROCESS | 18512 | [#5] yui.html Cycles:180 Average:12384.79 Median:44513.33 stddev:13721.63 (30.8%) stddev-sans-first:13732.42 08:01:53 INFO - PROCESS | 18512 | Values: 774.4 775.5 776.2 792.2 801.8 12405.9 12655.9 12701.6 12709.6 12761.9 11859.0 12070.1 12119.6 13408.7 13438.5 807.3 810.2 811.7 812.6 813.0 799.6 801.8 803.4 804.7 810.2 854.0 854.6 855.0 856.0 859.2 845.9 846.4 852.9 854.0 855.5 624.6 624.6 625.0 626.6 628.8 11924.8 11971.6 11999.9 12004.3 12671.2 11855.8 12030.5 12034.9 12142.4 12378.2 9529.1 9658.9 9765.2 9804.2 9923.0 3307.7 3316.9 3353.9 3363.2 3395.7 40477.8 43477.3 43788.6 43794.0 48691.3 9370.3 9526.4 9590.9 9653.4 9768.7 15115.5 15123.9 15132.7 15218.0 15253.2 6968.5 6995.4 7034.9 7054.6 7089.5 3975.4 3991.3 4069.4 4069.5 4072.3 2791.3 2851.9 2875.3 2878.7 2891.7 524.1 530.4 534.9 542.8 542.8 540.7 611.7 654.5 672.7 678.9 7621.8 7830.3 7948.6 8013.0 8153.3 601.7 635.7 638.7 659.9 666.8 3794.8 3946.1 3959.2 4082.6 4092.1 48363.8 49023.0 49631.3 49803.3 49980.8 43720.8 44164.3 44476.6 44550.1 44729.3 35173.6 39207.2 40161.0 41605.8 42826.4 7829.5 7901.0 7914.7 7918.2 8174.6 29126.6 29362.0 29425.7 30241.4 30307.4 37034.3 37117.8 37306.6 37518.9 38057.2 9968.4 10511.9 10644.7 10711.5 11091.6 10634.0 10758.0 11294.4 11754.7 11757.8 11197.6 11218.2 11282.2 11497.2 11534.3 10904.0 11092.6 11177.0 11210.7 11248.8 10980.0 11047.5 11187.6 11277.3 11288.7 8858.5 8903.6 9109.0 9227.7 9435.5 8952.8 9005.8 9033.4 9144.9 9378.5 08:01:53 INFO - PROCESS | 18512 | -------- Summary: end -------- 08:01:53 INFO - PROCESS | 18512 | 08:01:54 INFO - TEST-INFO | 18512: exit 0 08:01:54 INFO - TEST-OK | dromaeo_css | took 1114900ms 08:01:54 INFO - TEST-START | kraken 08:01:54 INFO - operating with platform_type : linux_ 08:01:54 INFO - Initialising browser for kraken test... 08:01:54 INFO - TEST-INFO | started process 18750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF2guOt/profile http://localhost:41055/getInfo.html) 08:01:57 INFO - PROCESS | 18750 | 08:01:57 INFO - PROCESS | 18750 | (process:18816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:01:58 INFO - PROCESS | 18750 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:01:58 INFO - PROCESS | 18750 | __metrics Screen width/height:1600/1200 08:01:58 INFO - PROCESS | 18750 | colorDepth:24 08:01:58 INFO - PROCESS | 18750 | Browser inner width/height: 1024/697 08:01:58 INFO - PROCESS | 18750 | __metrics 08:01:59 ERROR - PROCESS | 18750 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 08:02:00 INFO - TEST-INFO | 18750: exit 0 08:02:00 INFO - Browser initialized. 08:02:00 INFO - Running cycle 1/1 for kraken test... 08:02:00 INFO - TEST-INFO | started process 18867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF2guOt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:02 INFO - PROCESS | 18867 | 08:02:02 INFO - PROCESS | 18867 | (process:18925): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:02:12 INFO - PROCESS | 18867 | RSS: Main: 164331520 08:02:12 INFO - PROCESS | 18867 | 08:02:14 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41055/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:15 INFO - PROCESS | 18867 | RSS: Main: 168468480 08:02:15 INFO - PROCESS | 18867 | 08:02:18 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41055/tests/kraken/driver.html?testName=audio-dft) 08:02:19 INFO - PROCESS | 18867 | RSS: Main: 172781568 08:02:19 INFO - PROCESS | 18867 | 08:02:22 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41055/tests/kraken/driver.html?testName=audio-fft) 08:02:22 INFO - PROCESS | 18867 | RSS: Main: 163753984 08:02:22 INFO - PROCESS | 18867 | 08:02:24 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41055/tests/kraken/driver.html?testName=audio-oscillator) 08:02:25 INFO - PROCESS | 18867 | RSS: Main: 164745216 08:02:25 INFO - PROCESS | 18867 | 08:02:27 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41055/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:28 INFO - PROCESS | 18867 | RSS: Main: 164573184 08:02:28 INFO - PROCESS | 18867 | 08:02:31 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41055/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:32 INFO - PROCESS | 18867 | RSS: Main: 164487168 08:02:32 INFO - PROCESS | 18867 | 08:02:35 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41055/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:36 INFO - PROCESS | 18867 | RSS: Main: 163151872 08:02:36 INFO - PROCESS | 18867 | 08:02:39 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41055/tests/kraken/driver.html?testName=json-parse-financial) 08:02:40 INFO - PROCESS | 18867 | RSS: Main: 164139008 08:02:40 INFO - PROCESS | 18867 | 08:02:41 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41055/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:02:42 INFO - PROCESS | 18867 | RSS: Main: 164556800 08:02:42 INFO - PROCESS | 18867 | 08:02:44 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:44 INFO - PROCESS | 18867 | RSS: Main: 164524032 08:02:44 INFO - PROCESS | 18867 | 08:02:47 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:47 INFO - PROCESS | 18867 | RSS: Main: 164720640 08:02:47 INFO - PROCESS | 18867 | 08:02:50 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:51 INFO - PROCESS | 18867 | RSS: Main: 165449728 08:02:51 INFO - PROCESS | 18867 | 08:02:54 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:54 INFO - PROCESS | 18867 | RSS: Main: 164831232 08:02:54 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:41055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41055/tests/kraken/driver.html?testName=ai-astar) 08:02:56 INFO - PROCESS | 18867 | RSS: Main: 166473728 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | __start_tp_report 08:02:56 INFO - PROCESS | 18867 | _x_x_mozilla_page_load 08:02:56 INFO - PROCESS | 18867 | _x_x_mozilla_page_load_details 08:02:56 INFO - PROCESS | 18867 | |i|pagename|runs| 08:02:56 INFO - PROCESS | 18867 | |0;ai-astar;116;109;114;116;113;126;113;115;114;114 08:02:56 INFO - PROCESS | 18867 | |1;audio-beat-detection;162;131;161;186;135;166;156;145;190;134 08:02:56 INFO - PROCESS | 18867 | |2;audio-dft;164;163;162;165;167;163;163;160;164;161 08:02:56 INFO - PROCESS | 18867 | |3;audio-fft;74;75;75;162;78;77;76;73;150;74 08:02:56 INFO - PROCESS | 18867 | |4;audio-oscillator;94;94;151;95;95;94;145;94;94;142 08:02:56 INFO - PROCESS | 18867 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;117;117;117 08:02:56 INFO - PROCESS | 18867 | |6;imaging-darkroom;146;147;146;146;147;147;146;147;148;147 08:02:56 INFO - PROCESS | 18867 | |7;imaging-desaturate;96;96;97;96;96;96;96;95;96;95 08:02:56 INFO - PROCESS | 18867 | |8;json-parse-financial;65;67;65;65;66;65;64;64;65;64 08:02:56 INFO - PROCESS | 18867 | |9;json-stringify-tinderbox;65;65;64;64;65;63;66;64;64;64 08:02:56 INFO - PROCESS | 18867 | |10;stanford-crypto-aes;84;84;84;84;85;85;85;86;118;84 08:02:56 INFO - PROCESS | 18867 | |11;stanford-crypto-ccm;142;151;140;162;142;142;146;143;141;145 08:02:56 INFO - PROCESS | 18867 | |12;stanford-crypto-pbkdf2;179;181;173;172;175;175;176;176;174;182 08:02:56 INFO - PROCESS | 18867 | |13;stanford-crypto-sha256-iterative;73;72;70;74;73;71;72;75;73;71 08:02:56 INFO - PROCESS | 18867 | __end_tp_report 08:02:56 INFO - PROCESS | 18867 | __start_cc_report 08:02:56 INFO - PROCESS | 18867 | _x_x_mozilla_cycle_collect,927 08:02:56 INFO - PROCESS | 18867 | __end_cc_report 08:02:56 INFO - PROCESS | 18867 | __startTimestamp1460386976940__endTimestamp 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | ------- Summary: start ------- 08:02:56 INFO - PROCESS | 18867 | Number of tests: 14 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:4.35 (3.8%) stddev-sans-first:4.59 08:02:56 INFO - PROCESS | 18867 | Values: 116.0 109.0 114.0 116.0 113.0 126.0 113.0 115.0 114.0 114.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:161.50 stddev:20.77 (12.9%) stddev-sans-first:21.94 08:02:56 INFO - PROCESS | 18867 | Values: 162.0 131.0 161.0 186.0 135.0 166.0 156.0 145.0 190.0 134.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.99 (1.2%) stddev-sans-first:2.09 08:02:56 INFO - PROCESS | 18867 | Values: 164.0 163.0 162.0 165.0 167.0 163.0 163.0 160.0 164.0 161.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:34.20 (45.6%) stddev-sans-first:35.69 08:02:56 INFO - PROCESS | 18867 | Values: 74.0 75.0 75.0 162.0 78.0 77.0 76.0 73.0 150.0 74.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.08 (26.7%) stddev-sans-first:25.94 08:02:56 INFO - PROCESS | 18867 | Values: 94.0 94.0 151.0 95.0 95.0 94.0 145.0 94.0 94.0 142.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:02:56 INFO - PROCESS | 18867 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:02:56 INFO - PROCESS | 18867 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:02:56 INFO - PROCESS | 18867 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 08:02:56 INFO - PROCESS | 18867 | Values: 65.0 67.0 65.0 65.0 66.0 65.0 64.0 64.0 65.0 64.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 08:02:56 INFO - PROCESS | 18867 | Values: 65.0 65.0 64.0 64.0 65.0 63.0 66.0 64.0 64.0 64.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.50 stddev:10.60 (12.5%) stddev-sans-first:11.15 08:02:56 INFO - PROCESS | 18867 | Values: 84.0 84.0 84.0 84.0 85.0 85.0 85.0 86.0 118.0 84.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:144.00 stddev:6.64 (4.6%) stddev-sans-first:6.92 08:02:56 INFO - PROCESS | 18867 | Values: 142.0 151.0 140.0 162.0 142.0 142.0 146.0 143.0 141.0 145.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:3.33 (1.9%) stddev-sans-first:3.39 08:02:56 INFO - PROCESS | 18867 | Values: 179.0 181.0 173.0 172.0 175.0 175.0 176.0 176.0 174.0 182.0 08:02:56 INFO - PROCESS | 18867 | 08:02:56 INFO - PROCESS | 18867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.51 (2.1%) stddev-sans-first:1.58 08:02:56 INFO - PROCESS | 18867 | Values: 73.0 72.0 70.0 74.0 73.0 71.0 72.0 75.0 73.0 71.0 08:02:56 INFO - PROCESS | 18867 | -------- Summary: end -------- 08:02:56 INFO - PROCESS | 18867 | 08:02:57 INFO - TEST-INFO | 18867: exit 0 08:02:57 INFO - TEST-OK | kraken | took 63670ms 08:02:57 INFO - SUITE-END | took 1178s 08:02:58 INFO - Completed test suite (00:19:38) 08:02:58 INFO - javascript benchmark 08:02:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.5212861684895, 2711.0646826844745, 2743.2456074579486, 2753.876075576599, 2754.903578374757, 4788.281757736337, 4792.760361981896, 4808.6153107751425, 4824.807007719692, 4901.901961960759, 4726.85819425417, 4750.857474275768, 4798.328234047236, 4801.495842936485, 4870.829520966767, 4416.337549367605, 4477.059817438342, 4533.977330113345, 4538.546145385468, 4572.519885412017, 611.3082132657986, 4298.0, 4387.2541667916375, 4406.71356361837, 4439.778011099448, 4364.388985542027, 4365.890852728676, 4369.672274579403, 4388.451443569554, 4457.977710111429, 4359.849522907902, 4364.41080454141, 4372.715773474714, 4378.233809083429, 4410.3825464435, 4328.935065974013, 4352.7823608819745, 4357.520672725997, 4399.186150562125, 4414.293713005904, 4696.225122854725, 4707.552782485658, 4708.858734237979, 4710.576048155683, 4765.809367625291, 5117.283580298761, 5138.177891537373, 5141.665791723563, 5147.0, 5177.974110129425, 5079.288899554065, 5121.334226550562, 5160.767765450564, 5195.480451954774, 5211.817586384458, 4766.928496072562, 4778.187708089633, 4784.952150478485, 4837.0, 4838.637102217348, 5250.291210686585, 5253.3958594761325, 5259.263703081571, 5260.71066091361, 5268.288781014514, 4948.208286674115, 4998.775055122528, 5044.369453818273, 5067.721275329818, 5076.593872490192, 5108.772069785629, 5114.846554603368, 5121.718305493159, 5138.58891288696, 5147.433782283946, 5061.44324124346, 5065.924011139836, 5072.949270507322, 5074.441811400743, 5080.390353157644, 4946.035523073038, 5082.161443361878, 5100.923486147711, 5155.32980712505, 5170.302009228782, 4220.7467551946365, 4255.234057869613, 4262.25410553152, 4273.978630106892, 4295.5489673583825, 3705.629437056327, 3765.058735316171, 3782.924341513154, 3783.791891445942, 3804.771713697187, 4392.868213953587, 4435.82256709728, 4488.730676159441, 4504.1216962692615, 4537.659675524349, 5131.409887862869, 5161.200013997836, 5193.221016847428, 5203.0, 5240.868978275574, 4379.759113248802, 4550.089982003613, 4554.066416384633, 4559.908801824011, 4602.05657840142, 4583.702059366131, 4610.0, 4623.052274283764, 4660.673752837269, 4662.090892276042, 4739.763011849463, 4776.140294746979, 4834.7824347903725, 4838.661293709407, 4874.53691899269, 5037.219231019198, 5044.041632089891, 5104.1578139606545, 5107.744612769421, 5159.329287192641, 4857.611391088633, 4888.828890988798, 4889.3888263967, 4891.51084891508, 4927.28554359623, 5092.287079808756, 5094.5669618082875, 5096.617753668415, 5096.745162741922, 5151.381834179922, 5004.949950500449, 5146.382434107931, 5176.327077479904, 5178.611604129781, 5230.476952304739, 4954.355933728592, 4962.6774259673, 4975.452700203047, 4991.925121123113, 5019.949800501949, 4985.376827896513, 4986.102501549756, 4987.077390682735, 4990.051890141007, 5027.673201241908, 4849.733264670336, 4870.488598697086, 4910.92633610489, 4944.554990050912, 4968.130577149057, 5020.196768517019, 5033.421156567042, 5040.395152581714, 5048.72232027242, 5069.391672999263, 4874.683145595525, 4877.585405240594, 4885.560299573055, 4914.459409465027, 4958.479359667183], "value": 4683.797478333159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3611954610836, 600.2646757721791, 616.6053725615604, 616.8642898562316, 643.4884267007728, 31740.365192696132, 32341.353172936528, 32494.512582311254, 32552.348953020926, 32710.345793084125, 32834.0, 33062.834685826594, 33102.50346244808, 33442.0, 33450.66549334512, 4032.798360081999, 4046.514418269812, 4062.756234625917, 4065.227606754722, 4174.66602671787, 7416.666250018762, 7639.350655194287, 7646.923530764677, 7659.195784442637, 7660.387169026464, 7612.238776122399, 7635.121960974503, 7657.272559106904, 7689.077310722693, 7733.7679869604, 7645.579493127876, 7668.846623067508, 7715.72994945177, 7719.073711154698, 7728.845423091563, 7543.73596924105, 7627.313541781211, 7650.464467487278, 7657.387409007321, 7659.195784442609, 29836.701632983826, 33340.49989250163, 33720.32559348799, 33853.661463385295, 33944.15139621504, 2997.5353820157693, 3021.8035827671133, 3043.406535725512, 3133.937321253562, 3599.1182160370613, 23745.643815342784, 24100.87949560241, 24235.878820605783, 24709.258722238363, 24947.750522494724, 3136.2159460134967, 3284.835758212104, 3314.784539004957, 3335.816530090844, 3369.427197376452, 137857.0, 138708.30645846808, 139001.99999999898, 139089.0, 139507.30246348702, 30358.241043974078, 30556.236094097825, 31898.681013189573, 32672.183195420304, 32815.0, 30885.691143088283, 30943.0717078488, 30947.535786963213, 31035.224119396746, 31201.8439907799, 12466.563670271496, 12717.10980231375, 12775.425105870258, 12791.104622676323, 12819.16675416095, 10299.330543514647, 10379.792404152025, 10390.948045259725, 10402.895971040343, 10475.738106547245, 7968.402369822286, 7984.081830589556, 8057.556834374049, 8100.3519718422385, 8130.674773009014, 3157.636871759731, 3200.3439294944483, 3254.4792833146585, 3266.4773636218565, 3290.4570745826672, 889.902110767815, 918.7519369770125, 957.9042095790504, 981.0434826044692, 1037.3775734559204, 27371.0, 27854.16437506878, 28010.159695209175, 28117.0, 28212.85893570519, 965.6571916969515, 975.6048800235916, 996.5963784667222, 997.3068717241592, 1061.3950048472298, 14513.709725805425, 15002.374109708859, 15028.323725432381, 15109.0, 15168.772468412983, 309201.0, 312927.0, 314504.0, 314701.0, 316259.0, 46362.30456543154, 47050.5294947053, 47104.64476776148, 47233.76383118131, 47306.0, 1224.8285240066398, 1228.3673907937418, 1232.5254776910954, 1252.3049707412292, 1277.1506947879557, 26046.08838690637, 27164.0, 27259.59110613382, 27447.86276068607, 27669.169924902286, 40942.0, 41210.38184427296, 41430.0, 41457.0, 41554.58445415507, 269520.0, 269727.0, 271320.0, 272045.0, 272475.0, 24427.51144977126, 25002.124925627515, 37153.442698359, 38343.808280958416, 38545.22909541737, 37830.243395131394, 38188.2362352757, 38688.41967370548, 38994.220115598095, 39165.216695666495, 32615.021549353558, 33466.33067338688, 33735.32529349448, 33890.66109338974, 34088.318233635684, 32256.0, 33057.33885322328, 33243.0, 33433.49849752207, 33574.32851343008, 33127.0, 33579.83210083934, 37972.430413544374, 39493.60506394899, 39728.60271397249, 28926.566101508914, 30464.543031854984, 31015.379692405575, 31239.219019524695, 31243.375132496767, 24137.879310603334, 24618.138365157134, 24712.876435617705, 24976.250712478653, 25091.87454062718], "value": 15146.433397421433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.26563739701896, 369.93711069118257, 380.66501478698723, 382.1783166192685, 391.3054328566792, 15753.369865205392, 16630.916845415788, 17542.473725788215, 17674.381396651137, 17722.29110835565, 15965.361385544564, 16239.837601624009, 16884.493465196032, 16989.745153822703, 17015.57461063474, 4943.1596628573225, 5078.746062696869, 5121.871953201163, 5135.255387968742, 5135.871603209912, 3647.4893514907935, 5048.495150484959, 5355.0, 5603.719814009303, 5635.520980716644, 5558.249636299089, 5561.249231353756, 5587.469190426923, 5607.971960140214, 5613.410591887854, 5510.0, 5567.972160139194, 5701.2018317435595, 5719.399463056381, 5740.569457290678, 4996.7501624918605, 5019.548240658358, 5030.471800460972, 5031.7987280509105, 5036.244563315496, 18504.814951850443, 18672.719909201373, 18971.620567588572, 19045.904770476198, 19234.0, 1948.8538359623085, 2001.9184223212985, 2014.3252010576475, 2050.5046475445797, 2058.495668561197, 12875.227486350848, 13227.86772132276, 13472.25902575358, 13511.0, 13690.863091369058, 1679.0, 1751.5183324585714, 1771.3268957796083, 1836.4215272189351, 1858.721191821224, 67258.32741672569, 68312.6584367075, 69411.65294173548, 69480.3051969484, 70121.64939175271, 9028.322875784343, 9092.090790920987, 9277.257819374434, 9365.15713585767, 9546.522673866279, 12749.043821713409, 12777.808332875014, 12850.48598056086, 12891.806622900664, 12909.483620655068, 6840.0, 7059.188193357727, 7148.678309476086, 7213.963930180315, 7229.638518074181, 6737.056812046318, 6848.863022739617, 6862.622555759382, 6903.447724182053, 7048.224695283515, 5814.59297849155, 5904.9704751475965, 5911.527077833849, 5930.644161350247, 6019.976603977334, 1618.4659062509343, 1689.5860514174105, 1764.8323409276097, 1766.2316892151955, 1817.7636907202243, 872.3283072034498, 958.9041095890494, 968.9273304502191, 980.0150848397458, 1023.8566600675912, 16352.672946541003, 16635.41776037833, 16781.909175903525, 17044.48866534006, 17350.13249337528, 865.1737590600961, 867.3624885708999, 901.724973882972, 903.7921278106072, 947.9526023698787, 9429.15137637616, 9636.46999415039, 9773.047456428954, 9778.31551791382, 9821.754456138653, 121783.0, 407177.0, 409076.0, 418017.0, 419063.0, 63187.36812631815, 63766.36233637697, 64588.0, 65030.674846625465, 66931.66534167298, 918.9035151309016, 940.9388389754644, 958.750724811554, 959.7936443664506, 960.4045491795132, 14777.630559236106, 14956.042474801128, 15087.547373578811, 15175.848241517886, 15444.30500627452, 30849.845750771103, 31142.844285778425, 32525.34949301048, 32551.18622034468, 32969.835150824096, 42902.0, 43095.13809723851, 43390.566094338654, 43394.0, 43419.56580434282, 7203.387712044535, 7317.707291708272, 7380.704771809067, 7592.468527203043, 7730.342920851791, 10815.35107893529, 10843.67468975932, 11158.49786759614, 11443.713907152387, 11639.127065469955, 9277.16505514507, 9645.37305075168, 9743.951280243553, 10331.638392656221, 10401.53193106297, 9503.619855205714, 9530.714078577654, 10052.84920726175, 10365.429901355497, 10517.263791534519, 9853.719016527806, 10226.488675566043, 10522.684319470429, 10528.473576321307, 10532.473376331305, 7432.21961694036, 7511.661975211238, 7613.695452182073, 7745.7676269712, 7889.053313602404, 10292.948535257276, 10450.843237351293, 10620.20348473852, 10638.468076596295, 10663.253572249869], "value": 8176.257912296383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.9408423663053, 1492.6641505661225, 1636.1410259613701, 1792.2293413832047, 1806.421944977607, 6925.203601585819, 7385.593792341419, 7419.183889772121, 7648.541087534752, 7661.3487853532515, 7504.174540800507, 7506.849863002737, 7534.0582427196605, 7577.128630207528, 7591.0, 2159.373781603337, 2204.261572373257, 2207.4040009197506, 2212.6459766437374, 2216.235398787424, 2208.591410589046, 2209.5470428562185, 2247.5729611373868, 2255.9210427635035, 2259.2318611672026, 2209.0, 2243.461569223391, 2245.8989345479495, 2251.3583628665833, 2278.3734473019886, 2202.537467131904, 2216.4791274050585, 2223.5330580578097, 2227.543353612514, 2229.643257078868, 2157.1155826111217, 2186.4533866533366, 2192.7478339990944, 2193.2762188477764, 2200.966985495219, 7616.238376162395, 7646.885296720554, 7671.923280767177, 7705.730299439493, 7707.614619269014, 4539.228331183706, 4662.790174442158, 4673.95326046742, 4699.530046995307, 4700.882477938079, 2731.644886164806, 2915.3440475892967, 2966.332575170591, 2971.0, 2976.151796737941, 908.0783005249676, 921.9907800922039, 945.7966537194536, 947.6067432015706, 950.083169741203, 10374.63688770897, 10421.68734937953, 10430.739231519197, 10431.113355364803, 10439.269251152422, 4071.4096456013713, 4086.734362266443, 4258.5954334338185, 4260.382244574519, 4280.636145927569, 8920.063393343735, 8920.73237802867, 8921.330900182382, 8926.419782714103, 8941.105889411007, 4693.413323334583, 4711.0, 4720.0559888022535, 4726.220173671374, 4730.787114579852, 3700.0564855961557, 4171.8957026074595, 4282.443282373271, 4306.1172459645695, 4311.978440107842, 3588.138846676779, 3594.4248920172645, 3679.7240206984584, 3683.6316368363487, 3725.6088110748524, 1204.6205445284706, 1215.9392030398444, 1222.896053835416, 1228.6129869091208, 1235.4749231576543, 979.9755006124904, 1013.640157744005, 1015.6902144845893, 1095.7534554725123, 1255.1590434408968, 7143.678534465961, 7290.927090729131, 7344.632768361561, 7354.411647068222, 7393.630318484054, 431.34866351808995, 440.67830483746405, 442.4535698412458, 445.2097526889797, 446.01875873079354, 5452.400235974119, 5484.122540393598, 5498.257735205696, 5541.501264886179, 5670.801521946794, 9333.113354231336, 9667.323287369958, 9693.757656058655, 9701.029897010243, 9701.757456063513, 9577.473238971785, 9630.951845240868, 9635.614575416905, 9675.661351852652, 9701.563429645683, 7316.707331706779, 7388.963055184797, 7405.851882962311, 7410.184879663233, 7421.591812450259, 7184.6048467334795, 7234.6020968847215, 7352.96323518379, 7353.522021068614, 7362.852742945004, 8679.26226270774, 8819.823603528022, 8856.291496680122, 8885.600147993226, 9064.0, 8803.339749518684, 8967.730968070968, 9065.048169942062, 9100.544972751468, 9166.862497062682, 6154.538409619386, 6577.440917522064, 6789.355011273921, 6952.443804495527, 7026.473014524034, 7286.453515986216, 7346.96326518364, 7354.264573542603, 7384.963075184804, 7399.075115610549, 6394.488440924808, 6744.763933262312, 6771.28901465339, 6806.18325800907, 6913.032175495535, 6631.900521492278, 6633.270340262664, 6665.100211471389, 6762.357576030269, 6770.1537307836525, 6968.616726080114, 7153.535020223877, 7159.105111861018, 7179.7128114876905, 7198.928010719826, 6487.610743355413, 6489.318621544669, 6524.282328943717, 6525.2169739631545, 6557.114789503356, 6319.178506794087, 6365.522585806176, 6405.0392441132335, 6424.550281480251, 6426.228852537725], "value": 4330.460957907099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.64580149621946, 298.2781668362563, 301.49198600358386, 301.7540704325973, 306.82357644354494, 5194.376674799025, 5269.710165940872, 5359.856057576966, 5377.973110134453, 5392.137258038714, 5179.792808287664, 5234.476552344764, 5268.130758424865, 5269.262303277535, 5271.341082364705, 3913.8238779255003, 4049.8785036448953, 4072.5927407259333, 4155.189738001091, 4162.542120366757, 4130.153318569686, 4155.854545090922, 4162.97918510407, 4175.54069052404, 4188.371744238359, 4120.0, 4133.1320422711115, 4136.565660605638, 4156.127213285214, 4168.583141685823, 4050.8784736457956, 4115.382692596135, 4127.2570937231285, 4149.33610622299, 4151.356539736315, 3593.6047034826147, 3612.133088058847, 3618.4029635110173, 3621.040424287566, 3661.0, 5054.241863720435, 5066.138756411419, 5071.492850714936, 5076.923846142311, 5082.720450375228, 4416.447944006999, 4752.5485078917445, 4789.449213340476, 4801.231802911518, 4803.351547541072, 5638.774449022034, 5642.463965923231, 5646.604737668365, 5654.547636189095, 5660.179274005287, 3839.884803455901, 3850.84596616135, 3876.1472476055505, 3885.61143885612, 3887.961120388788, 5808.12878068289, 5884.08796636522, 5933.940660593382, 5963.105534169866, 5994.790182343597, 3989.3018721723583, 4001.6794457828846, 4005.0, 4012.29784787661, 4019.8191081401405, 4052.8176232069627, 4064.552899181088, 4067.2882245607493, 4068.4304197412384, 4074.572169922175, 4672.322513235562, 4690.108879312919, 4705.1765940960195, 4711.869151403638, 4720.244760838249, 5487.368952570426, 5605.0, 5622.522085622686, 5630.831075067755, 5649.237352957381, 1387.67389663429, 1399.846016938136, 1409.6405416618697, 1410.985890141106, 1411.3225651687249, 864.446754077391, 904.5793705926776, 920.374145580998, 948.4925564822787, 949.0699114867468, 4881.389826271716, 5013.649044566918, 5046.167382381939, 5049.84850454487, 5072.036313100499, 5785.623934444332, 5835.124731290341, 5870.178175055496, 5877.265341832271, 5880.647161170344, 4847.151748444078, 5015.1975683890405, 5016.194170098762, 5030.270610761419, 5049.671771334852, 3090.8300043497825, 3091.27355071558, 3093.1030001299823, 3121.8282994435526, 3147.2603938074535, 5524.779008839681, 5534.391216966131, 5535.059039963216, 5543.805966791143, 5566.916496252559, 5756.539476841843, 6028.758849646053, 6085.269767627825, 6090.482309003784, 6104.816855494253, 5530.253415788898, 5546.75039623226, 5551.500364967173, 5574.526165275915, 5584.888302233932, 5712.971435142797, 5841.912371314349, 5846.503047241032, 5847.26909136358, 5854.443827836349, 5771.682557459212, 5801.477866991991, 5808.651480911159, 5823.242978412949, 5829.15477255804, 5512.39363669988, 5542.307211598551, 5580.302462192226, 5587.1339942309005, 5602.722407391559, 3821.159344944108, 3962.54430740457, 3996.340603800457, 4021.1248956995887, 4046.5548789632526, 5835.620684655484, 5847.298324200953, 5852.268466441695, 5877.882442351043, 5883.294004719461, 5583.469570390806, 5632.408597097409, 5633.310006997803, 5649.548036157015, 5699.316082070178, 5536.169574563686, 5641.605087643826, 5649.689267090185, 5660.971695141498, 5664.5751568631695, 5261.868453288698, 5525.309336332958, 5547.861303467445, 5550.306211723535, 5576.972115139399, 5450.563954883679, 5624.268845050281, 5634.295713035871, 5671.291088613923, 5681.204631351531, 5455.399906010415, 5502.5597952164535, 5510.752016159363, 5513.751881165277, 5530.695811730394], "value": 4210.329111168891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.3921021997731, 775.511427800486, 776.2315307845231, 792.2236208515652, 801.7674874286457, 12405.937970310148, 12655.873441265585, 12701.555445559407, 12709.618711438672, 12761.872381276196, 11859.0, 12070.094742894275, 12119.636410907664, 13408.731825363511, 13438.462461501553, 807.2573232625969, 810.1574362662824, 811.7037281392309, 812.6180695073306, 812.9715459958887, 799.564237490569, 801.7995501124719, 803.4496369986549, 804.7143264141233, 810.1938571121713, 854.0178794386443, 854.6196942360652, 855.0423525651279, 855.9743207703748, 859.2138193552892, 845.9069502354736, 846.4032856835915, 852.8848605438279, 853.957302134897, 855.4738835616082, 624.5908929651085, 624.6158612453354, 624.9906251406233, 626.5551458464496, 628.7642134199675, 11924.821127683092, 11971.64085077449, 11999.94000030003, 12004.339761313124, 12671.17637353569, 11855.822162667568, 12030.4586293617, 12034.939825300906, 12142.392880356036, 12378.195417297848, 9529.142377186086, 9658.855117173249, 9765.16996055329, 9804.215662746963, 9922.9503852481, 3307.7353811695007, 3316.8839090631714, 3353.899383018513, 3363.209645733251, 3395.6604339566093, 40477.79761101205, 43477.34783978243, 43788.562114378765, 43794.0, 48691.26963095556, 9370.250379969586, 9526.428414295164, 9590.904090959, 9653.420794752337, 9768.706938791847, 15115.470958516398, 15123.924380378028, 15132.697346053237, 15218.0, 15253.237338133049, 6968.547044442196, 6995.370416662423, 7034.859302813915, 7054.6472676365975, 7089.539179953286, 3975.423563583322, 3991.3214753491975, 4069.409935559327, 4069.4709687740406, 4072.2873497137884, 2791.288221503504, 2851.8859245630356, 2875.2668069642527, 2878.668953070424, 2891.6530016397746, 524.0697761473339, 530.3635637235333, 534.8796520782793, 542.7937383794211, 542.8154427494592, 540.6972095626462, 611.7457170327358, 654.4862283107833, 672.7275453441364, 678.935501127402, 7621.771346859603, 7830.2952734254195, 7948.642311095899, 8012.959935200287, 8153.347732181412, 601.7412512619528, 635.7234602947733, 638.6966191059303, 659.8548319369731, 666.8099591616366, 3794.848206071726, 3946.131850992777, 3959.247742928892, 4082.6121518455698, 4092.07928216149, 48363.75818120887, 49023.0, 49631.25553116706, 49803.25295120576, 49980.750096249285, 43720.78139609282, 44164.337534937, 44476.55523444724, 44550.108997819865, 44729.32906006413, 35173.64826351704, 39207.21585568273, 40161.0, 41605.791971040555, 42826.35760463658, 7829.491083079582, 7901.0, 7914.722984695508, 7918.208179182036, 8174.591270436335, 29126.56310155307, 29362.0, 29425.70574294315, 30241.395172096876, 30307.393852122394, 37034.259314814095, 37117.81441092777, 37306.6269337314, 37518.87443376703, 38057.238855223295, 9968.352057116264, 10511.94744026275, 10644.680659580225, 10711.464426778786, 11091.611793587186, 10634.0, 10758.031777140095, 11294.378809165246, 11754.70613234676, 11757.76484470323, 11197.60808371703, 11218.220076742171, 11282.21024528308, 11497.19519633651, 11534.307941523535, 10904.0, 11092.556297748, 11177.0, 11210.66368008961, 11248.831267531157, 10979.971387696734, 11047.502862371373, 11187.552497900318, 11277.32336059839, 11288.717782055513, 8858.468491890508, 8903.599338029933, 9108.970199171155, 9227.677031303872, 9435.52822358893, 8952.820943581222, 9005.774855628662, 9033.412828166149, 9144.862827057466, 9378.498607987325], "value": 5929.472742370903, "unit": "score"}], "name": "dromaeo_css", "value": 6303.201387463639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 116.0, 113.0, 126.0, 113.0, 115.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 161.0, 186.0, 135.0, 166.0, 156.0, 145.0, 190.0, 134.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 165.0, 167.0, 163.0, 163.0, 160.0, 164.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 162.0, 78.0, 77.0, 76.0, 73.0, 150.0, 74.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 151.0, 95.0, 95.0, 94.0, 145.0, 94.0, 94.0, 142.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 63.0, 66.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 86.0, 118.0, 84.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 151.0, 140.0, 162.0, 142.0, 142.0, 146.0, 143.0, 141.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 173.0, 172.0, 175.0, 175.0, 176.0, 176.0, 174.0, 182.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 70.0, 74.0, 73.0, 71.0, 72.0, 75.0, 73.0, 71.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1607.4000000000003, "alertThreshold": 2.0}]} 08:02:58 INFO - Return code: 0 08:02:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:02:58 ERROR - # TBPL SUCCESS # 08:02:58 INFO - Running post-action listener: _resource_record_post_action 08:02:58 INFO - Running post-run listener: _resource_record_post_run 08:02:59 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518778880; Read time: 8; Write time: 375520 08:02:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233345024; Read time: 0; Write time: 179240 08:02:59 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285433856; Read time: 8; Write time: 196280 08:02:59 INFO - Running post-run listener: _upload_blobber_files 08:02:59 INFO - Blob upload gear active. 08:02:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:59 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 08:02:59 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'] 08:02:59 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 08:02:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:00 INFO - (blobuploader) - INFO - Done attempting. 08:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:01 INFO - (blobuploader) - INFO - Done attempting. 08:03:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:01 INFO - Return code: 0 08:03:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b68e49bd3792ef3dd916ac0380e1a4e12cafd23660af195f5412d617de8e38181c4bdb61e0e955e1a0154aad4efb50955714aef839c0ad52db49fa8cdc9fee3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32bc556d924a404d19a901df7440e48adb6ba8a2911f6256e6b812f115fa857c610f3bfa2bad0722e6b995d697f9f32ea732b261773a040f1bc433a251414428"} 08:03:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:01 INFO - Contents: 08:03:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b68e49bd3792ef3dd916ac0380e1a4e12cafd23660af195f5412d617de8e38181c4bdb61e0e955e1a0154aad4efb50955714aef839c0ad52db49fa8cdc9fee3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32bc556d924a404d19a901df7440e48adb6ba8a2911f6256e6b812f115fa857c610f3bfa2bad0722e6b995d697f9f32ea732b261773a040f1bc433a251414428"} 08:03:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:01 INFO - Copying logs to upload dir... 08:03:01 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.212291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-11 08:03:01.434705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 08:03:01.438944) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b68e49bd3792ef3dd916ac0380e1a4e12cafd23660af195f5412d617de8e38181c4bdb61e0e955e1a0154aad4efb50955714aef839c0ad52db49fa8cdc9fee3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32bc556d924a404d19a901df7440e48adb6ba8a2911f6256e6b812f115fa857c610f3bfa2bad0722e6b995d697f9f32ea732b261773a040f1bc433a251414428"} build_url:https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/bjiB7xw8SDWg5aQ8-BnACQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b68e49bd3792ef3dd916ac0380e1a4e12cafd23660af195f5412d617de8e38181c4bdb61e0e955e1a0154aad4efb50955714aef839c0ad52db49fa8cdc9fee3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32bc556d924a404d19a901df7440e48adb6ba8a2911f6256e6b812f115fa857c610f3bfa2bad0722e6b995d697f9f32ea732b261773a040f1bc433a251414428"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 08:03:01.468115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:03:01.468455) ========= 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=ed14279e38b05397cf4aa391000001a4-1460384728.90894-915472525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:03:01.550083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 08:03:01.550399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 08:03:01.550676) ========= ========= Total master_lag: 0.42 =========