builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1460616194.75 results: success (0) buildid: 20160413231446 builduid: 7bad776381cd417a804048f37d5dae6b revision: dbb14513cb83681e2c2832c712b95c23bc9bf468 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.748356) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.748728) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.749014) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006419 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.789794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.790109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.809122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.809418) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.861955) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.862301) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.862717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.863018) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 23:43:15-- 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% 66.3M=0s 2016-04-13 23:43:15 (66.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.992545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:14.992859) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022638 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.042185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.042512) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbb14513cb83681e2c2832c712b95c23bc9bf468 --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 dbb14513cb83681e2c2832c712b95c23bc9bf468 --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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 23:43:15,294 truncating revision to first 12 chars 2016-04-13 23:43:15,294 Setting DEBUG logging. 2016-04-13 23:43:15,294 attempt 1/10 2016-04-13 23:43:15,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbb14513cb83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 23:43:15,529 unpacking tar archive at: fx-team-dbb14513cb83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.569662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.569982) ========= echo dbb14513cb83681e2c2832c712b95c23bc9bf468 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dbb14513cb83681e2c2832c712b95c23bc9bf468'] 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dbb14513cb83681e2c2832c712b95c23bc9bf468 program finished with exit code 0 elapsedTime=0.003598 script_repo_revision: 'dbb14513cb83681e2c2832c712b95c23bc9bf468' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.617470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.617816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 23:43:15.628191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-13 23:43:15.628509) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:43:15 INFO - MultiFileLogger online at 20160413 23:43:15 in /builds/slave/test 23:43:15 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 23:43:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:43:15 INFO - {'append_to_log': False, 23:43:15 INFO - 'base_work_dir': '/builds/slave/test', 23:43:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:43:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:43:15 INFO - 'branch': 'Fx-Team-Non-PGO', 23:43:15 INFO - 'buildbot_json_path': 'buildprops.json', 23:43:15 INFO - 'config_files': ('talos/linux_config.py',), 23:43:15 INFO - 'default_actions': ('clobber', 23:43:15 INFO - 'read-buildbot-config', 23:43:15 INFO - 'download-and-extract', 23:43:15 INFO - 'populate-webroot', 23:43:15 INFO - 'create-virtualenv', 23:43:15 INFO - 'install', 23:43:15 INFO - 'run-tests'), 23:43:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:43:15 INFO - 'download_minidump_stackwalk': True, 23:43:15 INFO - 'download_symbols': 'ondemand', 23:43:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:43:15 INFO - 'tooltool.py': '/tools/tooltool.py', 23:43:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:43:15 INFO - '/tools/misc-python/virtualenv.py')}, 23:43:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:43:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:43:15 INFO - 'installer_path': 'installer.exe', 23:43:15 INFO - 'log_level': 'info', 23:43:15 INFO - 'log_name': 'talos', 23:43:15 INFO - 'log_to_console': True, 23:43:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:43:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:43:15 INFO - 'opt_config_files': (), 23:43:15 INFO - 'pip_index': False, 23:43:15 INFO - 'sps_profile': False, 23:43:15 INFO - 'sps_profile_interval': 0, 23:43:15 INFO - 'suite': 'dromaeojs-e10s', 23:43:15 INFO - 'system_bits': '32', 23:43:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:43:15 INFO - 'title': 'talos-linux64-ix-012', 23:43:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:43:15 INFO - 'use_talos_json': True, 23:43:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:43:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:43:15 INFO - 'work_dir': 'build'} 23:43:15 INFO - ##### 23:43:15 INFO - ##### Running clobber step. 23:43:15 INFO - ##### 23:43:15 INFO - Running pre-action listener: _resource_record_pre_action 23:43:15 INFO - Running main action method: clobber 23:43:15 INFO - rmtree: /builds/slave/test/build 23:43:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:43:16 INFO - Running post-action listener: _resource_record_post_action 23:43:16 INFO - ##### 23:43:16 INFO - ##### Running read-buildbot-config step. 23:43:16 INFO - ##### 23:43:16 INFO - Running pre-action listener: _resource_record_pre_action 23:43:16 INFO - Running main action method: read_buildbot_config 23:43:16 INFO - Using buildbot properties: 23:43:16 INFO - { 23:43:16 INFO - "project": "", 23:43:16 INFO - "product": "firefox", 23:43:16 INFO - "script_repo_revision": "production", 23:43:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:43:16 INFO - "repository": "", 23:43:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 23:43:16 INFO - "buildid": "20160413231446", 23:43:16 INFO - "pgo_build": "False", 23:43:16 INFO - "basedir": "/builds/slave/test", 23:43:16 INFO - "buildnumber": 1141, 23:43:16 INFO - "slavename": "talos-linux64-ix-012", 23:43:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:43:16 INFO - "platform": "ubuntu64_hw", 23:43:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:43:16 INFO - "branch": "fx-team", 23:43:16 INFO - "repo_path": "integration/fx-team", 23:43:16 INFO - "revision": "dbb14513cb83681e2c2832c712b95c23bc9bf468", 23:43:16 INFO - "stage_platform": "linux64", 23:43:16 INFO - "builduid": "7bad776381cd417a804048f37d5dae6b", 23:43:16 INFO - "slavebuilddir": "test" 23:43:16 INFO - } 23:43:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:43:16 INFO - Running post-action listener: _resource_record_post_action 23:43:16 INFO - ##### 23:43:16 INFO - ##### Running download-and-extract step. 23:43:16 INFO - ##### 23:43:16 INFO - Running pre-action listener: _resource_record_pre_action 23:43:16 INFO - Running main action method: download_and_extract 23:43:16 INFO - mkdir: /builds/slave/test/build/tests 23:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:16 INFO - https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:17 INFO - Downloaded 1361 bytes. 23:43:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:43:17 INFO - Using the following test package requirements: 23:43:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:43:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:43:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:43:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'jsshell-linux-x86_64.zip'], 23:43:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:43:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:43:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:43:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:43:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:43:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:43:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:43:17 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')]} 23:43:17 INFO - https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:43:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:43:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:43:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:19 INFO - Downloaded 22202881 bytes. 23:43:19 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'] 23:43:19 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 23:43:20 INFO - Return code: 0 23:43:20 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 23:43:20 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')]} 23:43:20 INFO - https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:39 INFO - Downloaded 22202881 bytes. 23:43:39 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'] 23:43:39 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 23:43:40 INFO - Return code: 0 23:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:40 INFO - https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:41 INFO - Downloaded 10841076 bytes. 23:43:41 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'] 23:43:41 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 23:43:41 INFO - Return code: 0 23:43:41 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')]} 23:43:41 INFO - https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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 23:43:44 INFO - Downloaded 54166710 bytes. 23:43:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:43:44 INFO - mkdir: /builds/slave/test/properties 23:43:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:43:44 INFO - Writing to file /builds/slave/test/properties/build_url 23:43:44 INFO - Contents: 23:43:44 INFO - build_url:https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:43:44 INFO - Running post-action listener: _resource_record_post_action 23:43:44 INFO - Running post-action listener: set_extra_try_arguments 23:43:44 INFO - ##### 23:43:44 INFO - ##### Running populate-webroot step. 23:43:44 INFO - ##### 23:43:44 INFO - Running pre-action listener: _resource_record_pre_action 23:43:44 INFO - Running main action method: populate_webroot 23:43:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:43:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:43:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:43:44 INFO - '--tppagecycles', 23:43:44 INFO - '7'], 23:43:44 INFO - 'tests': ['tsvgm']}}, 23:43:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:43:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:43:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:43:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:43:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:43:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:43:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['damp', 'tps']}, 23:43:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'tests': ['damp', 'tps']}, 23:43:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['dromaeo_dom']}, 23:43:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:43:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['a11yr', 23:43:44 INFO - 'ts_paint', 23:43:44 INFO - 'tpaint', 23:43:44 INFO - 'sessionrestore', 23:43:44 INFO - 'sessionrestore_no_auto_restore', 23:43:44 INFO - 'tabpaint']}, 23:43:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['tsvgx', 23:43:44 INFO - 'tsvgr_opacity', 23:43:44 INFO - 'tart', 23:43:44 INFO - 'tscrollx', 23:43:44 INFO - 'cart']}, 23:43:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:43:44 INFO - 'tsvgr_opacity', 23:43:44 INFO - 'tart', 23:43:44 INFO - 'tscrollx', 23:43:44 INFO - 'cart']}, 23:43:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'talos_options': ['--disable-e10s'], 23:43:44 INFO - 'tests': ['tp5o']}, 23:43:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'tests': ['tp5o']}, 23:43:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'talos_options': ['--disable-e10s', 23:43:44 INFO - '--xperf_path', 23:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:43:44 INFO - 'tests': ['tp5n']}, 23:43:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:44 INFO - 'talos_options': ['--xperf_path', 23:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:43:44 INFO - 'tests': ['tp5n']}}, 23:43:44 INFO - 'talos.zip': {'path': '', 23:43:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:43:44 INFO - Running post-action listener: _resource_record_post_action 23:43:44 INFO - ##### 23:43:44 INFO - ##### Running create-virtualenv step. 23:43:44 INFO - ##### 23:43:44 INFO - Running pre-action listener: _resource_record_pre_action 23:43:44 INFO - Running main action method: create_virtualenv 23:43:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:43:44 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 23:43:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:43:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:43:44 INFO - Using real prefix '/usr' 23:43:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:43:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:43:47 INFO - Installing pip.................done. 23:43:47 INFO - Return code: 0 23:43:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:43:47 INFO - Using env: {'DISPLAY': ':0', 23:43:47 INFO - 'HOME': '/home/cltbld', 23:43:47 INFO - 'LANG': 'en_US.UTF-8', 23:43:47 INFO - 'LANGUAGE': 'en_US:en', 23:43:47 INFO - 'LOGNAME': 'cltbld', 23:43:47 INFO - 'MAIL': '/var/mail/cltbld', 23:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:47 INFO - 'MOZ_NO_REMOTE': '1', 23:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:47 INFO - 'NO_EM_RESTART': '1', 23:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:47 INFO - 'PWD': '/builds/slave/test', 23:43:47 INFO - 'SHELL': '/bin/bash', 23:43:47 INFO - 'SHLVL': '1', 23:43:47 INFO - 'TERM': 'linux', 23:43:47 INFO - 'TMOUT': '86400', 23:43:47 INFO - 'USER': 'cltbld', 23:43:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:47 INFO - '_': '/tools/buildbot/bin/python'} 23:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:47 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 23:43:47 INFO - Cleaning up... 23:43:47 INFO - Return code: 0 23:43:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:43:47 INFO - Using env: {'DISPLAY': ':0', 23:43:47 INFO - 'HOME': '/home/cltbld', 23:43:47 INFO - 'LANG': 'en_US.UTF-8', 23:43:47 INFO - 'LANGUAGE': 'en_US:en', 23:43:47 INFO - 'LOGNAME': 'cltbld', 23:43:47 INFO - 'MAIL': '/var/mail/cltbld', 23:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:47 INFO - 'MOZ_NO_REMOTE': '1', 23:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:47 INFO - 'NO_EM_RESTART': '1', 23:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:47 INFO - 'PWD': '/builds/slave/test', 23:43:47 INFO - 'SHELL': '/bin/bash', 23:43:47 INFO - 'SHLVL': '1', 23:43:47 INFO - 'TERM': 'linux', 23:43:47 INFO - 'TMOUT': '86400', 23:43:47 INFO - 'USER': 'cltbld', 23:43:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:47 INFO - '_': '/tools/buildbot/bin/python'} 23:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:47 INFO - Downloading/unpacking psutil>=0.7.1 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:43:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:49 INFO - Installing collected packages: psutil 23:43:49 INFO - Running setup.py install for psutil 23:43:49 INFO - building 'psutil._psutil_linux' extension 23:43:49 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 23:43:50 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 23:43:50 INFO - building 'psutil._psutil_posix' extension 23:43:50 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 23:43:50 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 23:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:50 INFO - Successfully installed psutil 23:43:50 INFO - Cleaning up... 23:43:51 INFO - Return code: 0 23:43:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:43:51 INFO - Using env: {'DISPLAY': ':0', 23:43:51 INFO - 'HOME': '/home/cltbld', 23:43:51 INFO - 'LANG': 'en_US.UTF-8', 23:43:51 INFO - 'LANGUAGE': 'en_US:en', 23:43:51 INFO - 'LOGNAME': 'cltbld', 23:43:51 INFO - 'MAIL': '/var/mail/cltbld', 23:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:51 INFO - 'MOZ_NO_REMOTE': '1', 23:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:51 INFO - 'NO_EM_RESTART': '1', 23:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:51 INFO - 'PWD': '/builds/slave/test', 23:43:51 INFO - 'SHELL': '/bin/bash', 23:43:51 INFO - 'SHLVL': '1', 23:43:51 INFO - 'TERM': 'linux', 23:43:51 INFO - 'TMOUT': '86400', 23:43:51 INFO - 'USER': 'cltbld', 23:43:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:51 INFO - '_': '/tools/buildbot/bin/python'} 23:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:43:53 INFO - Installing collected packages: mozsystemmonitor 23:43:53 INFO - Running setup.py install for mozsystemmonitor 23:43:53 INFO - Successfully installed mozsystemmonitor 23:43:53 INFO - Cleaning up... 23:43:53 INFO - Return code: 0 23:43:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:43:53 INFO - Using env: {'DISPLAY': ':0', 23:43:53 INFO - 'HOME': '/home/cltbld', 23:43:53 INFO - 'LANG': 'en_US.UTF-8', 23:43:53 INFO - 'LANGUAGE': 'en_US:en', 23:43:53 INFO - 'LOGNAME': 'cltbld', 23:43:53 INFO - 'MAIL': '/var/mail/cltbld', 23:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:53 INFO - 'MOZ_NO_REMOTE': '1', 23:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:53 INFO - 'NO_EM_RESTART': '1', 23:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:53 INFO - 'PWD': '/builds/slave/test', 23:43:53 INFO - 'SHELL': '/bin/bash', 23:43:53 INFO - 'SHLVL': '1', 23:43:53 INFO - 'TERM': 'linux', 23:43:53 INFO - 'TMOUT': '86400', 23:43:53 INFO - 'USER': 'cltbld', 23:43:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:53 INFO - '_': '/tools/buildbot/bin/python'} 23:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:55 INFO - Downloading blobuploader-1.2.4.tar.gz 23:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:43:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:43:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:56 INFO - Downloading docopt-0.6.1.tar.gz 23:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:43:56 INFO - Installing collected packages: blobuploader, requests, docopt 23:43:56 INFO - Running setup.py install for blobuploader 23:43:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:43:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:43:56 INFO - Running setup.py install for requests 23:43:56 INFO - Running setup.py install for docopt 23:43:56 INFO - Successfully installed blobuploader requests docopt 23:43:56 INFO - Cleaning up... 23:43:57 INFO - Return code: 0 23:43:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:57 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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:43:57 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 23:43:57 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 23:43:57 INFO - Using env: {'DISPLAY': ':0', 23:43:57 INFO - 'HOME': '/home/cltbld', 23:43:57 INFO - 'LANG': 'en_US.UTF-8', 23:43:57 INFO - 'LANGUAGE': 'en_US:en', 23:43:57 INFO - 'LOGNAME': 'cltbld', 23:43:57 INFO - 'MAIL': '/var/mail/cltbld', 23:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:57 INFO - 'MOZ_NO_REMOTE': '1', 23:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:57 INFO - 'NO_EM_RESTART': '1', 23:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:57 INFO - 'PWD': '/builds/slave/test', 23:43:57 INFO - 'SHELL': '/bin/bash', 23:43:57 INFO - 'SHLVL': '1', 23:43:57 INFO - 'TERM': 'linux', 23:43:57 INFO - 'TMOUT': '86400', 23:43:57 INFO - 'USER': 'cltbld', 23:43:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:57 INFO - '_': '/tools/buildbot/bin/python'} 23:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:57 INFO - Running setup.py (path:/tmp/pip-gDdLbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:57 INFO - Running setup.py (path:/tmp/pip-n6Z58p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:57 INFO - Running setup.py (path:/tmp/pip-5fDUEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:57 INFO - Running setup.py (path:/tmp/pip-pNDc57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:57 INFO - Running setup.py (path:/tmp/pip-x_Fvgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:57 INFO - Running setup.py (path:/tmp/pip-4hPZ5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:57 INFO - Running setup.py (path:/tmp/pip-YOcGyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:57 INFO - Running setup.py (path:/tmp/pip-fdbeZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:57 INFO - Running setup.py (path:/tmp/pip-2Nlozf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:57 INFO - Running setup.py (path:/tmp/pip-eWqPs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:57 INFO - Running setup.py (path:/tmp/pip-24Lr3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:58 INFO - Running setup.py (path:/tmp/pip-0nOv9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:58 INFO - Running setup.py (path:/tmp/pip-r0PXoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:58 INFO - Running setup.py (path:/tmp/pip-lsDYNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:58 INFO - Running setup.py (path:/tmp/pip-M3ChbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:58 INFO - Running setup.py (path:/tmp/pip-455CeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:58 INFO - Running setup.py (path:/tmp/pip-Q0DsqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:43:58 INFO - Running setup.py install for manifestparser 23:43:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:43:58 INFO - Running setup.py install for mozcrash 23:43:58 INFO - Running setup.py install for mozdebug 23:43:58 INFO - Running setup.py install for mozdevice 23:43:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:43:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:43:58 INFO - Running setup.py install for mozfile 23:43:58 INFO - Running setup.py install for mozhttpd 23:43:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozinfo 23:43:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozInstall 23:43:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozleak 23:43:59 INFO - Running setup.py install for mozlog 23:43:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for moznetwork 23:43:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozprocess 23:43:59 INFO - Running setup.py install for mozprofile 23:43:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozrunner 23:43:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:43:59 INFO - Running setup.py install for mozscreenshot 23:44:00 INFO - Running setup.py install for moztest 23:44:00 INFO - Running setup.py install for mozversion 23:44:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:44:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:44:00 INFO - Cleaning up... 23:44:00 INFO - Return code: 0 23:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:00 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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:44:00 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 23:44:00 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 23:44:00 INFO - Using env: {'DISPLAY': ':0', 23:44:00 INFO - 'HOME': '/home/cltbld', 23:44:00 INFO - 'LANG': 'en_US.UTF-8', 23:44:00 INFO - 'LANGUAGE': 'en_US:en', 23:44:00 INFO - 'LOGNAME': 'cltbld', 23:44:00 INFO - 'MAIL': '/var/mail/cltbld', 23:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:00 INFO - 'MOZ_NO_REMOTE': '1', 23:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:00 INFO - 'NO_EM_RESTART': '1', 23:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:00 INFO - 'PWD': '/builds/slave/test', 23:44:00 INFO - 'SHELL': '/bin/bash', 23:44:00 INFO - 'SHLVL': '1', 23:44:00 INFO - 'TERM': 'linux', 23:44:00 INFO - 'TMOUT': '86400', 23:44:00 INFO - 'USER': 'cltbld', 23:44:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:00 INFO - '_': '/tools/buildbot/bin/python'} 23:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:44:00 INFO - Running setup.py (path:/tmp/pip-rWbLnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:44:00 INFO - Running setup.py (path:/tmp/pip-1lOEa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:44:00 INFO - Running setup.py (path:/tmp/pip-Dz7H7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:44:00 INFO - Running setup.py (path:/tmp/pip-7kh_VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:44:00 INFO - Running setup.py (path:/tmp/pip-tQZSmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:44:00 INFO - Running setup.py (path:/tmp/pip-RAX893-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:44:00 INFO - Running setup.py (path:/tmp/pip-vOY01I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:44:00 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)) 23:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:44:00 INFO - Running setup.py (path:/tmp/pip-n_PrxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:44:01 INFO - Running setup.py (path:/tmp/pip-Z8DPkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:44:01 INFO - Running setup.py (path:/tmp/pip-C58l3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:44:01 INFO - Running setup.py (path:/tmp/pip-LE5OtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:44:01 INFO - Running setup.py (path:/tmp/pip-G8gmCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:44:01 INFO - Running setup.py (path:/tmp/pip-nXOyF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:44:01 INFO - Running setup.py (path:/tmp/pip-Jhemu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:01 INFO - Running setup.py (path:/tmp/pip-nHRhw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:44:01 INFO - Running setup.py (path:/tmp/pip-2aoyfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:44:01 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)) 23:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:44:01 INFO - Running setup.py (path:/tmp/pip-ku0dKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:44:01 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)) 23:44:01 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)) 23:44:01 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)) 23:44:01 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)) 23:44:01 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)) 23:44:01 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)) 23:44:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:44: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 23:44: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 23:44: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 23:44: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 23:44: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 23:44: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 23:44:03 INFO - Downloading blessings-1.6.tar.gz 23:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:44:03 INFO - Installing collected packages: blessings 23:44:03 INFO - Running setup.py install for blessings 23:44:03 INFO - Successfully installed blessings 23:44:03 INFO - Cleaning up... 23:44:03 INFO - Return code: 0 23:44:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:44:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:44:04 INFO - Reading from file tmpfile_stdout 23:44:04 INFO - Current package versions: 23:44:04 INFO - argparse == 1.2.1 23:44:04 INFO - blessings == 1.6 23:44:04 INFO - blobuploader == 1.2.4 23:44:04 INFO - docopt == 0.6.1 23:44:04 INFO - manifestparser == 1.1 23:44:04 INFO - mozInstall == 1.12 23:44:04 INFO - mozcrash == 0.17 23:44:04 INFO - mozdebug == 0.1 23:44:04 INFO - mozdevice == 0.48 23:44:04 INFO - mozfile == 1.2 23:44:04 INFO - mozhttpd == 0.7 23:44:04 INFO - mozinfo == 0.9 23:44:04 INFO - mozleak == 0.1 23:44:04 INFO - mozlog == 3.1 23:44:04 INFO - moznetwork == 0.27 23:44:04 INFO - mozprocess == 0.22 23:44:04 INFO - mozprofile == 0.28 23:44:04 INFO - mozrunner == 6.11 23:44:04 INFO - mozscreenshot == 0.1 23:44:04 INFO - mozsystemmonitor == 0.0 23:44:04 INFO - moztest == 0.7 23:44:04 INFO - mozversion == 1.4 23:44:04 INFO - psutil == 3.1.1 23:44:04 INFO - requests == 1.2.3 23:44:04 INFO - wsgiref == 0.1.2 23:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:44:04 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')]} 23:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:04 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')]} 23:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:04 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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:44:04 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 23:44:04 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 23:44:04 INFO - Using env: {'DISPLAY': ':0', 23:44:04 INFO - 'HOME': '/home/cltbld', 23:44:04 INFO - 'LANG': 'en_US.UTF-8', 23:44:04 INFO - 'LANGUAGE': 'en_US:en', 23:44:04 INFO - 'LOGNAME': 'cltbld', 23:44:04 INFO - 'MAIL': '/var/mail/cltbld', 23:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:04 INFO - 'MOZ_NO_REMOTE': '1', 23:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:04 INFO - 'NO_EM_RESTART': '1', 23:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:04 INFO - 'PWD': '/builds/slave/test', 23:44:04 INFO - 'SHELL': '/bin/bash', 23:44:04 INFO - 'SHLVL': '1', 23:44:04 INFO - 'TERM': 'linux', 23:44:04 INFO - 'TMOUT': '86400', 23:44:04 INFO - 'USER': 'cltbld', 23:44:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:04 INFO - '_': '/tools/buildbot/bin/python'} 23:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 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)) 23:44:04 INFO - Cleaning up... 23:44:04 INFO - Return code: 0 23:44:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:44:04 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')]} 23:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:04 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')]} 23:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:04 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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:44:04 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 23:44:04 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 23:44:04 INFO - Using env: {'DISPLAY': ':0', 23:44:04 INFO - 'HOME': '/home/cltbld', 23:44:04 INFO - 'LANG': 'en_US.UTF-8', 23:44:04 INFO - 'LANGUAGE': 'en_US:en', 23:44:04 INFO - 'LOGNAME': 'cltbld', 23:44:04 INFO - 'MAIL': '/var/mail/cltbld', 23:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:04 INFO - 'MOZ_NO_REMOTE': '1', 23:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:04 INFO - 'NO_EM_RESTART': '1', 23:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:04 INFO - 'PWD': '/builds/slave/test', 23:44:04 INFO - 'SHELL': '/bin/bash', 23:44:04 INFO - 'SHLVL': '1', 23:44:04 INFO - 'TERM': 'linux', 23:44:04 INFO - 'TMOUT': '86400', 23:44:04 INFO - 'USER': 'cltbld', 23:44:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:04 INFO - '_': '/tools/buildbot/bin/python'} 23:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:04 INFO - Downloading/unpacking jsonschema 23:44:04 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 23:44:04 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 23:44:04 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 23:44:04 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 23:44:04 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 23:44:04 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 23:44:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:44:06 INFO - Downloading/unpacking functools32 (from jsonschema) 23:44:06 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 23:44:06 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 23:44:06 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 23:44:06 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 23:44:06 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 23:44:06 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 23:44:06 INFO - Downloading functools32-3.2.3-2.tar.gz 23:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:44:06 INFO - warning: no files found matching '*.txt' 23:44:06 INFO - no previously-included directories found matching 'build' 23:44:06 INFO - no previously-included directories found matching 'dist' 23:44:06 INFO - no previously-included directories found matching '.git*' 23:44:06 INFO - Installing collected packages: jsonschema, functools32 23:44:06 INFO - Running setup.py install for functools32 23:44:06 INFO - warning: no files found matching '*.txt' 23:44:06 INFO - no previously-included directories found matching 'build' 23:44:06 INFO - no previously-included directories found matching 'dist' 23:44:06 INFO - no previously-included directories found matching '.git*' 23:44:06 INFO - Successfully installed jsonschema functools32 23:44:06 INFO - Cleaning up... 23:44:06 INFO - Return code: 0 23:44:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:06 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 0x7ff478f28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', '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 23:44:06 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 23:44:06 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 23:44:06 INFO - Using env: {'DISPLAY': ':0', 23:44:06 INFO - 'HOME': '/home/cltbld', 23:44:06 INFO - 'LANG': 'en_US.UTF-8', 23:44:06 INFO - 'LANGUAGE': 'en_US:en', 23:44:06 INFO - 'LOGNAME': 'cltbld', 23:44:06 INFO - 'MAIL': '/var/mail/cltbld', 23:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:06 INFO - 'MOZ_NO_REMOTE': '1', 23:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:06 INFO - 'NO_EM_RESTART': '1', 23:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:06 INFO - 'PWD': '/builds/slave/test', 23:44:06 INFO - 'SHELL': '/bin/bash', 23:44:06 INFO - 'SHLVL': '1', 23:44:06 INFO - 'TERM': 'linux', 23:44:06 INFO - 'TMOUT': '86400', 23:44:06 INFO - 'USER': 'cltbld', 23:44:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:06 INFO - '_': '/tools/buildbot/bin/python'} 23:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:07 INFO - Downloading/unpacking flake8 23:44:07 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 23:44:07 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 23:44:07 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 23:44:07 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 23:44:07 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 23:44:07 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 23:44:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:44:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:44:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 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 23:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:44:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:44:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:44:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:44:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:44:09 INFO - no previously-included directories found matching 'docs/_build' 23:44:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:44:09 INFO - Running setup.py install for pep8 23:44:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:44:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:44:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:44:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:44:09 INFO - no previously-included directories found matching 'docs/_build' 23:44:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:44:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:44:09 INFO - Cleaning up... 23:44:09 INFO - Return code: 0 23:44:09 INFO - Running post-action listener: _resource_record_post_action 23:44:09 INFO - Running post-action listener: _start_resource_monitoring 23:44:10 INFO - Starting resource monitoring. 23:44:10 INFO - ##### 23:44:10 INFO - ##### Running install step. 23:44:10 INFO - ##### 23:44:10 INFO - Running pre-action listener: _resource_record_pre_action 23:44:10 INFO - Running main action method: install 23:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:44:10 INFO - Reading from file tmpfile_stdout 23:44:10 INFO - Detecting whether we're running mozinstall >=1.0... 23:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:44:10 INFO - Reading from file tmpfile_stdout 23:44:10 INFO - Output received: 23:44:10 INFO - Usage: mozinstall [options] installer 23:44:10 INFO - Options: 23:44:10 INFO - -h, --help show this help message and exit 23:44:10 INFO - -d DEST, --destination=DEST 23:44:10 INFO - Directory to install application into. [default: 23:44:10 INFO - "/builds/slave/test"] 23:44:10 INFO - --app=APP Application being installed. [default: firefox] 23:44:10 INFO - mkdir: /builds/slave/test/build/application 23:44:10 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'] 23:44:10 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 23:44:25 INFO - Reading from file tmpfile_stdout 23:44:25 INFO - Output received: 23:44:25 INFO - /builds/slave/test/build/application/firefox/firefox 23:44:25 INFO - Running post-action listener: _resource_record_post_action 23:44:25 INFO - ##### 23:44:25 INFO - ##### Running run-tests step. 23:44:25 INFO - ##### 23:44:25 INFO - Running pre-action listener: _resource_record_pre_action 23:44:25 INFO - Running main action method: run_tests 23:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:44:25 INFO - Python 2.7.3 23:44:25 INFO - Return code: 0 23:44:25 INFO - grabbing minidump binary from tooltool 23:44:25 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')]} 23:44:25 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 0x1527410>, '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 0x1528310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15287a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:44:25 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 23:44:25 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 23:44:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:44:25 INFO - Return code: 0 23:44:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:44:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:44:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:44:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:44:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:44:27 INFO - Return code: 0 23:44:27 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/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:44:27 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/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 23:44:27 INFO - Using env: {'DISPLAY': ':0', 23:44:27 INFO - 'HOME': '/home/cltbld', 23:44:27 INFO - 'LANG': 'en_US.UTF-8', 23:44:27 INFO - 'LANGUAGE': 'en_US:en', 23:44:27 INFO - 'LOGNAME': 'cltbld', 23:44:27 INFO - 'MAIL': '/var/mail/cltbld', 23:44:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:44:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:27 INFO - 'MOZ_NO_REMOTE': '1', 23:44:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:27 INFO - 'NO_EM_RESTART': '1', 23:44:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:27 INFO - 'PWD': '/builds/slave/test', 23:44:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:44:27 INFO - 'SHELL': '/bin/bash', 23:44:27 INFO - 'SHLVL': '1', 23:44:27 INFO - 'TERM': 'linux', 23:44:27 INFO - 'TMOUT': '86400', 23:44:27 INFO - 'USER': 'cltbld', 23:44:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771', 23:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:27 INFO - '_': '/tools/buildbot/bin/python'} 23:44:27 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/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:44:27 INFO - mozversion application_buildid: 20160413231446 23:44:27 INFO - mozversion application_changeset: dbb14513cb83681e2c2832c712b95c23bc9bf468 23:44:27 INFO - mozversion application_display_name: Nightly 23:44:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:44:27 INFO - mozversion application_name: Firefox 23:44:27 INFO - mozversion application_remotingname: firefox 23:44:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:44:27 INFO - mozversion application_vendor: Mozilla 23:44:27 INFO - mozversion application_version: 48.0a1 23:44:27 INFO - mozversion platform_buildid: 20160413231446 23:44:27 INFO - mozversion platform_changeset: dbb14513cb83681e2c2832c712b95c23bc9bf468 23:44:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:44:27 INFO - mozversion platform_version: 48.0a1 23:44:27 INFO - using testdate: 1460616267 23:44:27 INFO - actual date: 1460616267 23:44:27 INFO - starting webserver on 'localhost:51024' 23:44:27 INFO - SUITE-START | Running 2 tests 23:44:27 INFO - TEST-START | dromaeo_css 23:44:27 INFO - operating with platform_type : linux_ 23:44:27 INFO - Initialising browser for dromaeo_css test... 23:44:27 INFO - TEST-INFO | started process 7106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRzqTVq/profile http://localhost:51024/getInfo.html) 23:44:30 INFO - PROCESS | 7106 | 23:44:30 INFO - PROCESS | 7106 | (process:7173): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:44:30 INFO - PROCESS | 7106 | 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] 23:44:31 INFO - PROCESS | 7106 | __metrics Screen width/height:1600/1200 23:44:31 INFO - PROCESS | 7106 | colorDepth:24 23:44:31 INFO - PROCESS | 7106 | Browser inner width/height: 1024/697 23:44:31 INFO - PROCESS | 7106 | __metrics 23:44:32 ERROR - PROCESS | 7106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 23:44:32 INFO - TEST-INFO | 7106: exit 0 23:44:32 INFO - Browser initialized. 23:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:44:32 INFO - TEST-INFO | started process 7224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRzqTVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:34 INFO - PROCESS | 7224 | 23:44:34 INFO - PROCESS | 7224 | (process:7282): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:44:44 INFO - PROCESS | 7224 | RSS: Main: 164401152 23:44:44 INFO - PROCESS | 7224 | 23:45:34 INFO - PROCESS | 7224 | 1460616334538 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] 23:47:45 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51024/tests/dromaeo/cssquery-ext.html) 23:47:46 INFO - PROCESS | 7224 | RSS: Main: 168050688 23:47:46 INFO - PROCESS | 7224 | 23:50:49 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-ext.html (next: http://localhost:51024/tests/dromaeo/cssquery-jquery.html) 23:50:49 INFO - PROCESS | 7224 | RSS: Main: 164741120 23:50:49 INFO - PROCESS | 7224 | 23:53:51 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51024/tests/dromaeo/cssquery-mootools.html) 23:53:52 INFO - PROCESS | 7224 | RSS: Main: 167124992 23:53:52 INFO - PROCESS | 7224 | 23:56:53 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51024/tests/dromaeo/cssquery-prototype.html) 23:56:54 INFO - PROCESS | 7224 | RSS: Main: 163688448 23:56:54 INFO - PROCESS | 7224 | 23:59:57 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51024/tests/dromaeo/cssquery-yui.html) 23:59:57 INFO - PROCESS | 7224 | RSS: Main: 164929536 23:59:57 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-yui.html (next: http://localhost:51024/tests/dromaeo/cssquery-dojo.html) 00:03:00 INFO - PROCESS | 7224 | RSS: Main: 167313408 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | __start_tp_report 00:03:00 INFO - PROCESS | 7224 | _x_x_mozilla_page_load 00:03:00 INFO - PROCESS | 7224 | _x_x_mozilla_page_load_details 00:03:00 INFO - PROCESS | 7224 | |i|pagename|runs| 00:03:00 INFO - PROCESS | 7224 | |0;dojo.html;2626.6716660417446;2707.12018593957;2745.629340039094;2759.0757096372713;2764.1431156341537;4652.488226295105;4673.929891051633;4674.953250467494;4676.321933319671;4719.480857105716;4633.814647414099;4767.594754445876;4770.809167633299;4840.322354870321;4847.200211965031;4333.285007973681;4402.273624851896;4417.491988421324;4422.71252368595;4423.51341352451;575.7333819623973;4271.850485233017;4307.741535507864;4390.209762242795;4392.9560704393025;4307.353896915456;4321.9135617287475;4327.632151267146;4344.022594916134;4399.956000439986;4340.131973605292;4349.84775532858;4352.347147927804;4356.651467882593;4388.341748737683;4321.395004699345;4379.036611945398;4385.583369579885;4389.714668546534;4428;4648.395708557866;4660.300954856764;4664.067186562667;4671.27595222741;4699.177643912301;4976.552110310089;4986.152354099811;5095.082885080684;5107.846764597068;5118.820841270575;5082.059818933509;5083.186690129599;5094.490550944913;5119.411267704225;5139.460356662571;4717.95282047182;4725.149473094842;4729.95270047302;4735.526447355306;4763;5093.770780314895;5144.38267407906;5151.304573882478;5201.557867581298;5229.163333866639;4942.703437793743;4964.726940018334;4965.702057876539;4973.254011898244;5018.372703412074;5058.772355244023;5059.06407314648;5060.746962651852;5072.137736584789;5133.25567792668;5021.153750435504;5035.144025515598;5078.568321692697;5111.437741848394;5133.897322053538;4978.128827455181;4984.102861484895;4990.351254336913;5007.824726134568;5053.837617347957;4237.555056719062;4286.935695964563;4287.506936702257;4296.097819457948;4328.264195086843;3691.9077023074638;3739.457778622085;3777.036855601804;3803.980980095137;3844.4809950656304;4290.849820256276;4294.334378171388;4335.458067741532;4372.672049596293;4381.737095774264;5031.295618613397;5033.496650335011;5035.395752509649;5037.4458809530925;5038.571721403649;4510.503844577094;4512.097580483916;4550.931736023962;4573.49691533931;4596.931046034312;4565.840195593139;4570.268756998864;4575.588197062214;4620.099080679235;4623.12160689468;4812.25410061441;4836.516348365276;4846.055019271208;4858.392700912386;4871.3667223260745;5147.9227811583605;5164.457731938092;5164.9741751291;5172.120739474223;5208.9321689052895;4924.482929292372;4925.704457732548;4938.185199442196;4940.456549779449;4990.076835785391;4807.879803004953;4982.501749824988;5074.2642316864585;5088.262201980618;5109.770060347368;5151.433342332415;5158.922616160686;5162.328897243335;5175;5176.9741151294;4938.728369939688;4984.302197692254;4985.850424487271;5007.198848184273;5019.0965626187635;4764.76176191196;4937.086638971802;4982.775775090057;5006.424261210008;5048.5203905628905;4887.315775791463;4896.877578060577;4897.534734200245;4924.63065270099;4942.184539550934;4955.82654607087;4990.850274491771;4997.125503037027;4999.250112483157;5064.139096353555;4803.735794531194;4879.56083952446;4916.434610019894;4919.901601967869;4981.078500477423 00:03:00 INFO - PROCESS | 7224 | |1;ext.html;544.7474548881014;582.9825105246842;597.2415032908209;597.7489454429141;619.3868070610098;33086.17284567887;34202.828985855034;34227.31545369091;34232.1441963951;34275.82862085689;34422;34612.30775384491;34631.307373852505;34752;34881.82559087201;7392.482526223166;7627.54234745917;7644.120926093487;7648;7670.386369090459;7516.736914208004;7788.221177882223;7789.636813557633;7806.804829879242;7808.375329973617;7713.112992005907;7794;7856.057273127232;7858.29275365217;7866.68533258669;7717;7722.884156737653;7806.921930780704;7818.648160832719;7826.217378262185;7746.690132394698;7836.804079897991;7846.333061689763;7855;7876.645550950221;29622.70377296221;34889.12777180565;35037.47443788345;35173.472397914054;35233.47149792755;2880.7119288071026;2946.337074158297;3044.9543256850943;3094.226443389153;3166.9841650791827;26995;27090.864545677145;27414.314642133908;27698.723012769817;27711.445771084665;2980.210244285266;2990.5065664165386;3014.125903487986;3019.1999120233154;3073.031994921615;237331;242388.78805606035;242921;243186;243219.7585181101;58088.128678069865;58393.124103138485;58875;59025.40974590285;59178.40821591729;59370;61715.38284617096;63276.68361658162;63645.68177159177;63799.6810015947;14214.360353784105;14283.857161428252;14367.281635918162;14431.35058922351;14443.49447769344;10608.575656973635;10658.946705266579;10717.678469645924;10757.677269681923;10767.6231331903;19035.524111897314;19063.618727625646;19146.138423770964;19295.90352048231;19812.306569270007;7556.962215188999;7675.117361503499;7686.57723825195;7773.844523109619;7779.105402878628;872.9650813967497;978.5938835383237;989.6486747204639;1015.5156496619958;1022.7340891368298;28313.71686283152;28451.71548284532;29368.706312936596;29478.263043423656;29504.557431638543;975.7219192530094;995.7908839143716;1005.8139244239838;1040.3341861208833;1078.2182917384832;14930.925345373204;15244.618884527754;15320.923395382952;15497.922510387376;15723;348803;354360;357539;357724;358790;48549.5145048545;49332;49338.50661493411;49445.50554494481;49452.50547494479;1231.870653581379;1256.5664845628244;1261.6593519749615;1265.7531781302741;1390.7009992851586;26668.866655667374;27719;27736.44527109406;28609.427811443238;28786;42861.3570796432;42937.14125717406;43054.78472607617;43352.78323608362;43393.3490997629;311519;312641;313240;314345;315420;26089.08688195904;26708.332291692084;26795.732042680105;41131.38302925519;42632.36051459169;41610.16779664329;41902.37146442867;42018.36972445354;42112.36831447592;42801.143977120904;35650.643493564734;36028;36084.81957590195;36299.81850090733;36458;33998.66001339955;34079.82960085184;34263.65736342605;34326.48510272298;34778.30443391067;35137.64862351446;35302.29395412129;36781.816090920445;37109.257814844095;38361;29546.852265739395;31806.84096579502;31842.68157318397;32154;32326.83836580802;25063.373415664755;25122.12072577451;25167.87416062908;25539.36151596225;25686.357841054123 00:03:00 INFO - PROCESS | 7224 | |2;jquery.html;384.52895203375857;385.39108209029735;391.5008364335472;394.56794809683385;396.1403753854136;15389.384424623016;16149.677006459864;16631.417900373475;16638.41935016173;16652.08413537258;16188.514344569652;16384.098874561896;16401.507954761375;16583.83416165838;16694.165291735426;5103.948960510394;5248.448912864133;5310.07073762092;5336.573074154077;5347.385050719159;3653.8903832885057;5756.222909907172;6119.724612392431;6135.447809697126;6137.232845894263;4941.505849415065;6058.666773327465;6080.300765411968;6097.115918191859;6113.602615829979;5178.974105129469;5190.71451070191;5200.557952573998;5202.479752024805;5208.531232189083;4925.990172014728;5272.657277276965;5305.893882122375;5307.9734601326745;5336.653117547347;18309.45071647853;18735.625287494175;19028.048597570203;19051.237950481966;19332.516687082796;1788.3963812916982;1868.1499917537487;1916.808319168086;2200.4388880835286;2469.3085935937966;8704.086070962585;8808;8876.511791851446;8942.821143577157;9044.77388065297;1749.1691446562781;1760.7622970898892;1773.804881463038;1783.9197236124405;1833.5324492254524;67431;69178;70052.29947700509;70822.64588677076;71577;9387.202087822476;9643.9035609643;10286.485675716185;10290.861138065648;10307.94846025765;14573.344199511048;14584;14615.342309596093;14624.341904614104;14655.413783448756;6990.720371185197;7176.533525320941;7299.941508481241;7417.517861338995;7445.143808461988;7043.436525077981;7050.471214658921;7081.150261968493;7223.566586004857;7238.782836514913;4356.3683265926265;4408.933865992013;4418.1163767246035;4440.089781594766;4508.661850361236;1680.983190168107;3159.4470967580583;3218.8229647369153;3259.3436349375183;3512.455569386749;888.2627419242014;934.9485778282124;937.3579098317674;966.7196513011288;972.6206779356057;16292.918535407247;16673.6665266694;17044.829551704574;17310.65378692419;17375.826241737675;909.1408618855119;915.4004127296631;940.1022023967095;967.4002118686459;1000.6297669862198;9338.20625246848;9528.380655257386;9535.666251681158;9652.951735241279;9818.969008254173;388430;393500;396590;401676;403038;74274;75609;76429.61785191039;76973.61513192399;78252.21747782563;980.4901451245455;988.1304452082265;1025.2105878473533;1026.9435181064964;1033.34382667007;14850.554483365084;14971.625709356918;14982.40070397172;15108.697826043197;15367.30847111905;32632.184195395304;32721.18197045093;34348.48477272793;34561.65438345585;34700.13249668779;45018.77490612526;45129.774351128035;47154.292685609056;47815.521844781106;48629.513704863915;4717.622590192845;5401.270828438111;5661.716914154358;6544.640044797582;6944.652767361713;10465.029111172436;11649.534018639159;11775.882241177822;11777.116716246144;11786.58746943853;10239.795204095728;10248.59005639796;10280.588776448858;10354.844677329695;10451.529681164518;10213.74465638365;10283;10293.588256469957;10304.639337623148;10392.16862650971;10234.692959211236;10480.842787358044;10568.365898046142;10617.893821062;10745.570177192825;6948.826279343057;7037.472189585904;7167.354938055391;7168.139823221247;7214.2785721427435;9637.37357071788;10341.793164136825;10437.739056523647;10535.937265870958;10761.461926903467 00:03:00 INFO - PROCESS | 7224 | |3;mootools.html;1443.5019918128241;1480.4596322342345;1605.3899518183096;1769.0535563473545;1782.7504149419083;6887.931120688791;7572.697092116316;7621.58081305528;7865.882011769821;7891.526508409499;7722.884156737639;7736.34241089508;7771.92228077719;7773.572453515055;7786.065672119354;2274.2608652188023;2299.8620082795087;2301.861888286708;2302.5049614332916;2304.6197377432704;2232.096001119541;2235;2299.2872209615075;2303.170858490942;2303.928673166977;2242.6299660555987;2245.9101635934626;2281.7946384825364;2311.3181611424584;2317.8841057947034;2225.7996780289773;2232.363776323748;2241.7309922809204;2242.091952759135;2249.6850440938283;2186.8469207155504;2201.1305534313856;2212.203606701586;2218.201447478906;2232.5088480534255;7927.048754149481;7968.442209045369;7976.6809327626825;7992.080910695228;7999.640016199285;4610.101030299093;4693.507181745902;4717.575418212377;4777.5222477752295;4778.259369797687;2898.2754311422145;3000.7899447038717;3105.2392163919985;3119.485284927984;3141.3717256548553;900.7027680865299;904.452806052342;914.6295750221171;914.8856392950881;930.3208657679932;10360.481975901175;10469.31949423285;10475.685729428129;10482.63310784119;10506.632267870664;4183.1215444756335;4192.350185721157;4320.719153255091;4348.717333373321;4450.710703804242;8977.461352318882;8986.68546600866;8992.595333210022;8996.415233009964;9008.504532250658;4715.717056976592;4734.55021772931;4771.284307353924;4789.4971028042255;4795.184818580849;3772.0946972726347;4174;4243.193793179286;4331.220380331571;4351.108022855307;3715.16408808016;3717.4052151655605;3754.5682246541996;3805.1058001369656;3807.2575847709986;1216.738401243737;1248.2323371126693;1274.8980081593636;1279.7632437998814;1287.1440492072668;720.8882623193414;810.2707563193055;882.1399135842502;909.8180363927241;910.9635614575343;5267.236250743621;5458.836234912879;5472.616916815864;5508.44915508454;5509.256250406224;853.2448782827242;872.31959071924;937.1986951156799;960.4477425480377;962.138885697297;3884.76691398517;3896.649301562873;3933.547642021147;3948.1511475033008;3953.87314615339;9300.11648893354;9551.379160354554;9650.420974741539;9657.806843863224;9834.114929656365;9399.060093990547;9452.90547094534;9515.429074255568;9573.32986690939;9590.232781377474;7218.8917166242545;7253.927460725326;7417.221191774786;7429.62851857405;7441.590712510864;5484.862878428071;5514.889702206014;5586.553075754011;5700.458456446631;5764.394738552559;8851.601677924638;8867.068957759342;8892.421992570462;8935.061818508962;8993.055729148346;8755.781105472413;8858.202761751474;9062.909370906207;9117.77205569866;9193.724188274362;6242.781502647385;6771.830704232433;6893.448524118159;7046.506744528039;7055.858882822417;7742.264484873928;7749.457537972513;7773.37812974972;7790.415718820997;7822.4524283299625;6808.693608787517;6986.336298051677;7028.297170282931;7032.472564557576;7103.325184107502;6920.619365934922;6947.062146610143;6966.407855332353;6986.266442023514;7077.5753454792875;6136.570440069152;6354.23749150105;6398.936010639834;6402.487800975818;6457.870842583028;4503.189425903369;4615.907681846412;4671.135839869635;4723.574878260973;4737.407824021997;4851.781669824796;4906.435759887516;4919.065377578248;4935.777889994887;4981.402231732215 00:03:00 INFO - PROCESS | 7224 | |4;prototype.html;317.64423845293277;318.9744820414367;326.25939118201677;329.93401319736057;332.390064232134;5235.424103348633;5320.547753440953;5325.20121981703;5327.7336133193285;5339.492748188925;5246.878107526016;5281.18141688038;5282.788688452467;5293.655912365703;5302.708351040691;3929.2337994091163;3992;4123.814428350732;4128.3601041838565;4130.607592278744;4113.786433002271;4120.608542188503;4136.214119317335;4136.97931510342;4158.708890377675;4096.446979657752;4138;4143.689223308249;4145.502539695241;4149.3775933609895;4039.9798001009954;4098.877033688979;4117.711760176789;4120.340745480738;4140.875773726793;3610.5667319921513;3616.8372423241017;3623.601403845575;3633.182533929871;3633.65480279373;5020.322256495399;5050.141475949097;5056.393232812049;5064.139096353629;5081.568066714333;4592.714040068786;4751;4756.500567440438;4766.428028636551;4779.091972525209;5515.172724091419;5517.944820551783;5527.296711203503;5545.3086808523385;5546.084895992157;3972.741771784825;3978.900527486836;3981.124152686404;3984.342583473723;3985.900352491182;5610.186522954149;5749.540036797046;5796.5072968797285;5803.245578074823;5806.912896306559;4052.756834589934;4064.776437295918;4090.8159132839096;4091.6931230157857;4093.2222877653153;4141.7722025288895;4142.357934520094;4151.647109995623;4155.148194620096;4168.041350489404;4691;4717.386739723814;4722.244440889442;4733;4735.763211839394;5371.382291036581;5521.806736764194;5545.667259964334;5558.221848941152;5577.581681373913;1436.8778653814543;1457.6880807273326;1462.1300326305832;1466.4207637982936;1467.4423718986716;916.9862452063225;971.140540621555;995.1889210293588;1008.6318493749728;1035.1460045462522;4859.538343857328;4904.2643603459765;4949.925751113737;4953.578945789648;4969.0807200668;5706;5716.342620598602;5729.28383952006;5730.426957304319;5743.913841292384;4740.881477963078;4893.9021219576125;4908.877278068006;4923.852284431473;5036.622253331015;3054.9694503054684;3067;3077.7383922366403;3094.3501864608684;3095.613048368954;5477.616566840283;5479.369872464717;5495.642783219078;5497.587680923947;5508.641938274;5757.395473475225;5857.941420585825;5898;5898.820235952827;5935.169076329317;5463.31708536433;5479.698616576047;5510.8071217507195;5526.143447765683;5531.612787104945;5673.801416950387;5777.133429985536;5792.073268277224;5801.071828507418;5826.912596311144;5680.869673872298;5696.800611978727;5703.20155178267;5714.20001199824;5716.657000579812;5516.310461192351;5533.2253484513;5535.861603459945;5541.335039795089;5564.054110801255;3941.7240793144206;4020.175863947942;4040.616141466556;4045.130296986162;4047.372657238133;5793.131030345482;5808.128780682931;5815.41845815415;5822.883542329215;5841.094630332305;5627.155926611041;5628.437156284339;5633.6619802811965;5634.802781902614;5637.701944362594;5447.291852059207;5526.143447765603;5607.943920560742;5611.80358687444;5612.635178713534;5167.6641018333685;5444.292242008513;5450.427705090909;5450.700211488248;5461.290032295935;5389.380221274603;5578.609497335147;5608.915866262091;5622;5651;5425.403205647454;5459.416769137065;5494.478024587817;5497.3952865184;5520.006398848085 00:03:00 INFO - PROCESS | 7224 | |5;yui.html;647.9190101237346;728.5191773429531;757.4697711601876;789.1556035042503;801.6953557648096;11221.214514983954;11942.522299108035;12096.516139354415;12137.15039947204;12165.57420490283;11104.056790061728;11267.549298028069;11321.433928303593;11337.886621133786;11605.245659032156;649.0426620734427;808.9029316482031;822.4859462835727;823.3372135430976;823.423603477565;789.7670187294761;815.6981916690833;816.9387295952797;822.8847961285425;824.5258976088772;853.5092321914892;855.700504823313;858.6608289725585;859.3168431097262;864.1790299215738;843.8734189871507;846.7883029242689;848.4612271207797;848.6138806842903;850.0649285785648;623.392192612204;625.1185827982569;625.7653379982506;626.4424662050778;628.8144997225829;11454.770904581861;11547.422628868522;11584.42077896102;11614.941925290319;11648.534058637644;12133.93933030338;12340.81488777669;12732.681682957907;13126;13271.800922986164;9976.800463990752;10035;10067.093961543424;10341.741456463573;10478.10936070435;3222.387746328214;3318.7510936679605;3322.5016247562817;3340.1816554943953;3365.562476878015;45456.54543454589;45580.772096139306;47047.99999999966;47231;47395;10128.898711012944;10147.797044059225;10191.082802547806;10194.082532572103;10232.846507302396;16926.492205233862;18418.07909604541;18447.446576602455;18457;18457.1694273758;6718.529702920749;6755.695993680296;6763.525805567304;6769.153855768029;6794.9660251699415;3689.0592898810633;3709.295233905549;3872.53529576447;3875.6124387561017;3916.4516967624554;2824.759895408913;2957.822530648168;3046.7562594992346;3066.938661226763;3070.7389871860696;541.8130744893006;551.7710150287586;559.6138664321605;563.9436056394328;564.0889962710194;506.683322923173;540.348879600081;593.6912805341199;611.1077826373545;614.7786796753165;7527.3225409712295;7615.961920190363;7829.843403131906;7862.33170180541;8044;501.3707796715172;609.1654433426235;628.1676778268812;631.564220687724;648.7859006527834;3617.3127105849803;3670.44943258508;3675.7794532328144;3697.2790305890094;3787.886363409102;45503.54496454993;46347.768261158475;46655;53923;54824;41935;42389.15221695549;42728.78635606802;42873;43460.3480947786;38728.612713873066;39687.40468892969;40554.594454055674;40906.59093409088;41799.58200418018;7851.332636725942;7851.764447066597;7918.960405197937;7931.444798864024;8197.34421246287;26716.599251010863;26967.86516067407;27031.45937081208;27441.17676469709;27641.44717105687;34977.475337869444;36593.45109823302;38848.805755971036;39309.2138157241;39422.60577394189;10460.529276182438;10567.154627629618;10808.837867432152;11003.394813285026;11093.44532773342;11921.403929803648;12082.516699331929;12130.636080917586;12177.391130443266;12454.065945053975;11184.328940263285;11460.484278207667;11589.942050289694;11970.341631210018;11981.22122062098;11145.888541114486;11214.66356009321;11585.246958947642;11861.525538978343;11875.940620296844;9503.334766566273;10961.725956850823;11043.668689939315;11427.542898283975;11438.599649012245;9335.346525743133;9491.620335186515;9612.231021518402;9613.423194608346;9628.855567166358;8505.23452889243;8704.390692651454;9268.907310926805;9777.85333219988;10157.238207134347 00:03:00 INFO - PROCESS | 7224 | __end_tp_report 00:03:00 INFO - PROCESS | 7224 | __start_cc_report 00:03:00 INFO - PROCESS | 7224 | _x_x_mozilla_cycle_collect,365 00:03:00 INFO - PROCESS | 7224 | __end_cc_report 00:03:00 INFO - PROCESS | 7224 | __startTimestamp1460617380523__endTimestamp 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | ------- Summary: start ------- 00:03:00 INFO - PROCESS | 7224 | Number of tests: 6 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#0] dojo.html Cycles:165 Average:4683.24 Median:4879.56 stddev:582.44 (11.9%) stddev-sans-first:561.43 00:03:00 INFO - PROCESS | 7224 | Values: 2626.7 2707.1 2745.6 2759.1 2764.1 4652.5 4673.9 4675.0 4676.3 4719.5 4633.8 4767.6 4770.8 4840.3 4847.2 4333.3 4402.3 4417.5 4422.7 4423.5 575.7 4271.9 4307.7 4390.2 4393.0 4307.4 4321.9 4327.6 4344.0 4400.0 4340.1 4349.8 4352.3 4356.7 4388.3 4321.4 4379.0 4385.6 4389.7 4428.0 4648.4 4660.3 4664.1 4671.3 4699.2 4976.6 4986.2 5095.1 5107.8 5118.8 5082.1 5083.2 5094.5 5119.4 5139.5 4718.0 4725.1 4730.0 4735.5 4763.0 5093.8 5144.4 5151.3 5201.6 5229.2 4942.7 4964.7 4965.7 4973.3 5018.4 5058.8 5059.1 5060.7 5072.1 5133.3 5021.2 5035.1 5078.6 5111.4 5133.9 4978.1 4984.1 4990.4 5007.8 5053.8 4237.6 4286.9 4287.5 4296.1 4328.3 3691.9 3739.5 3777.0 3804.0 3844.5 4290.8 4294.3 4335.5 4372.7 4381.7 5031.3 5033.5 5035.4 5037.4 5038.6 4510.5 4512.1 4550.9 4573.5 4596.9 4565.8 4570.3 4575.6 4620.1 4623.1 4812.3 4836.5 4846.1 4858.4 4871.4 5147.9 5164.5 5165.0 5172.1 5208.9 4924.5 4925.7 4938.2 4940.5 4990.1 4807.9 4982.5 5074.3 5088.3 5109.8 5151.4 5158.9 5162.3 5175.0 5177.0 4938.7 4984.3 4985.9 5007.2 5019.1 4764.8 4937.1 4982.8 5006.4 5048.5 4887.3 4896.9 4897.5 4924.6 4942.2 4955.8 4990.9 4997.1 4999.3 5064.1 4803.7 4879.6 4916.4 4919.9 4981.1 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#1] ext.html Cycles:180 Average:46267.88 Median:34691.65 stddev:80704.84 (232.6%) stddev-sans-first:80858.23 00:03:00 INFO - PROCESS | 7224 | Values: 544.7 583.0 597.2 597.7 619.4 33086.2 34202.8 34227.3 34232.1 34275.8 34422.0 34612.3 34631.3 34752.0 34881.8 7392.5 7627.5 7644.1 7648.0 7670.4 7516.7 7788.2 7789.6 7806.8 7808.4 7713.1 7794.0 7856.1 7858.3 7866.7 7717.0 7722.9 7806.9 7818.6 7826.2 7746.7 7836.8 7846.3 7855.0 7876.6 29622.7 34889.1 35037.5 35173.5 35233.5 2880.7 2946.3 3045.0 3094.2 3167.0 26995.0 27090.9 27414.3 27698.7 27711.4 2980.2 2990.5 3014.1 3019.2 3073.0 237331.0 242388.8 242921.0 243186.0 243219.8 58088.1 58393.1 58875.0 59025.4 59178.4 59370.0 61715.4 63276.7 63645.7 63799.7 14214.4 14283.9 14367.3 14431.4 14443.5 10608.6 10658.9 10717.7 10757.7 10767.6 19035.5 19063.6 19146.1 19295.9 19812.3 7557.0 7675.1 7686.6 7773.8 7779.1 873.0 978.6 989.6 1015.5 1022.7 28313.7 28451.7 29368.7 29478.3 29504.6 975.7 995.8 1005.8 1040.3 1078.2 14930.9 15244.6 15320.9 15497.9 15723.0 348803.0 354360.0 357539.0 357724.0 358790.0 48549.5 49332.0 49338.5 49445.5 49452.5 1231.9 1256.6 1261.7 1265.8 1390.7 26668.9 27719.0 27736.4 28609.4 28786.0 42861.4 42937.1 43054.8 43352.8 43393.3 311519.0 312641.0 313240.0 314345.0 315420.0 26089.1 26708.3 26795.7 41131.4 42632.4 41610.2 41902.4 42018.4 42112.4 42801.1 35650.6 36028.0 36084.8 36299.8 36458.0 33998.7 34079.8 34263.7 34326.5 34778.3 35137.6 35302.3 36781.8 37109.3 38361.0 29546.9 31806.8 31842.7 32154.0 32326.8 25063.4 25122.1 25167.9 25539.4 25686.4 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#2] jquery.html Cycles:180 Average:24220.45 Median:402357.00 stddev:65395.24 (16.3%) stddev-sans-first:65554.20 00:03:00 INFO - PROCESS | 7224 | Values: 384.5 385.4 391.5 394.6 396.1 15389.4 16149.7 16631.4 16638.4 16652.1 16188.5 16384.1 16401.5 16583.8 16694.2 5103.9 5248.4 5310.1 5336.6 5347.4 3653.9 5756.2 6119.7 6135.4 6137.2 4941.5 6058.7 6080.3 6097.1 6113.6 5179.0 5190.7 5200.6 5202.5 5208.5 4926.0 5272.7 5305.9 5308.0 5336.7 18309.5 18735.6 19028.0 19051.2 19332.5 1788.4 1868.1 1916.8 2200.4 2469.3 8704.1 8808.0 8876.5 8942.8 9044.8 1749.2 1760.8 1773.8 1783.9 1833.5 67431.0 69178.0 70052.3 70822.6 71577.0 9387.2 9643.9 10286.5 10290.9 10307.9 14573.3 14584.0 14615.3 14624.3 14655.4 6990.7 7176.5 7299.9 7417.5 7445.1 7043.4 7050.5 7081.2 7223.6 7238.8 4356.4 4408.9 4418.1 4440.1 4508.7 1681.0 3159.4 3218.8 3259.3 3512.5 888.3 934.9 937.4 966.7 972.6 16292.9 16673.7 17044.8 17310.7 17375.8 909.1 915.4 940.1 967.4 1000.6 9338.2 9528.4 9535.7 9653.0 9819.0 388430.0 393500.0 396590.0 401676.0 403038.0 74274.0 75609.0 76429.6 76973.6 78252.2 980.5 988.1 1025.2 1026.9 1033.3 14850.6 14971.6 14982.4 15108.7 15367.3 32632.2 32721.2 34348.5 34561.7 34700.1 45018.8 45129.8 47154.3 47815.5 48629.5 4717.6 5401.3 5661.7 6544.6 6944.7 10465.0 11649.5 11775.9 11777.1 11786.6 10239.8 10248.6 10280.6 10354.8 10451.5 10213.7 10283.0 10293.6 10304.6 10392.2 10234.7 10480.8 10568.4 10617.9 10745.6 6948.8 7037.5 7167.4 7168.1 7214.3 9637.4 10341.8 10437.7 10535.9 10761.5 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#3] mootools.html Cycles:180 Average:5227.09 Median:5512.07 stddev:2838.13 (51.5%) stddev-sans-first:2831.84 00:03:00 INFO - PROCESS | 7224 | Values: 1443.5 1480.5 1605.4 1769.1 1782.8 6887.9 7572.7 7621.6 7865.9 7891.5 7722.9 7736.3 7771.9 7773.6 7786.1 2274.3 2299.9 2301.9 2302.5 2304.6 2232.1 2235.0 2299.3 2303.2 2303.9 2242.6 2245.9 2281.8 2311.3 2317.9 2225.8 2232.4 2241.7 2242.1 2249.7 2186.8 2201.1 2212.2 2218.2 2232.5 7927.0 7968.4 7976.7 7992.1 7999.6 4610.1 4693.5 4717.6 4777.5 4778.3 2898.3 3000.8 3105.2 3119.5 3141.4 900.7 904.5 914.6 914.9 930.3 10360.5 10469.3 10475.7 10482.6 10506.6 4183.1 4192.4 4320.7 4348.7 4450.7 8977.5 8986.7 8992.6 8996.4 9008.5 4715.7 4734.6 4771.3 4789.5 4795.2 3772.1 4174.0 4243.2 4331.2 4351.1 3715.2 3717.4 3754.6 3805.1 3807.3 1216.7 1248.2 1274.9 1279.8 1287.1 720.9 810.3 882.1 909.8 911.0 5267.2 5458.8 5472.6 5508.4 5509.3 853.2 872.3 937.2 960.4 962.1 3884.8 3896.6 3933.5 3948.2 3953.9 9300.1 9551.4 9650.4 9657.8 9834.1 9399.1 9452.9 9515.4 9573.3 9590.2 7218.9 7253.9 7417.2 7429.6 7441.6 5484.9 5514.9 5586.6 5700.5 5764.4 8851.6 8867.1 8892.4 8935.1 8993.1 8755.8 8858.2 9062.9 9117.8 9193.7 6242.8 6771.8 6893.4 7046.5 7055.9 7742.3 7749.5 7773.4 7790.4 7822.5 6808.7 6986.3 7028.3 7032.5 7103.3 6920.6 6947.1 6966.4 6986.3 7077.6 6136.6 6354.2 6398.9 6402.5 6457.9 4503.2 4615.9 4671.1 4723.6 4737.4 4851.8 4906.4 4919.1 4935.8 4981.4 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#4] prototype.html Cycles:180 Average:4636.42 Median:5281.99 stddev:1346.30 (25.5%) stddev-sans-first:1310.47 00:03:00 INFO - PROCESS | 7224 | Values: 317.6 319.0 326.3 329.9 332.4 5235.4 5320.5 5325.2 5327.7 5339.5 5246.9 5281.2 5282.8 5293.7 5302.7 3929.2 3992.0 4123.8 4128.4 4130.6 4113.8 4120.6 4136.2 4137.0 4158.7 4096.4 4138.0 4143.7 4145.5 4149.4 4040.0 4098.9 4117.7 4120.3 4140.9 3610.6 3616.8 3623.6 3633.2 3633.7 5020.3 5050.1 5056.4 5064.1 5081.6 4592.7 4751.0 4756.5 4766.4 4779.1 5515.2 5517.9 5527.3 5545.3 5546.1 3972.7 3978.9 3981.1 3984.3 3985.9 5610.2 5749.5 5796.5 5803.2 5806.9 4052.8 4064.8 4090.8 4091.7 4093.2 4141.8 4142.4 4151.6 4155.1 4168.0 4691.0 4717.4 4722.2 4733.0 4735.8 5371.4 5521.8 5545.7 5558.2 5577.6 1436.9 1457.7 1462.1 1466.4 1467.4 917.0 971.1 995.2 1008.6 1035.1 4859.5 4904.3 4949.9 4953.6 4969.1 5706.0 5716.3 5729.3 5730.4 5743.9 4740.9 4893.9 4908.9 4923.9 5036.6 3055.0 3067.0 3077.7 3094.4 3095.6 5477.6 5479.4 5495.6 5497.6 5508.6 5757.4 5857.9 5898.0 5898.8 5935.2 5463.3 5479.7 5510.8 5526.1 5531.6 5673.8 5777.1 5792.1 5801.1 5826.9 5680.9 5696.8 5703.2 5714.2 5716.7 5516.3 5533.2 5535.9 5541.3 5564.1 3941.7 4020.2 4040.6 4045.1 4047.4 5793.1 5808.1 5815.4 5822.9 5841.1 5627.2 5628.4 5633.7 5634.8 5637.7 5447.3 5526.1 5607.9 5611.8 5612.6 5167.7 5444.3 5450.4 5450.7 5461.3 5389.4 5578.6 5608.9 5622.0 5651.0 5425.4 5459.4 5494.5 5497.4 5520.0 00:03:00 INFO - PROCESS | 7224 | 00:03:00 INFO - PROCESS | 7224 | [#5] yui.html Cycles:180 Average:12459.44 Median:40121.00 stddev:13798.33 (34.4%) stddev-sans-first:13808.52 00:03:00 INFO - PROCESS | 7224 | Values: 647.9 728.5 757.5 789.2 801.7 11221.2 11942.5 12096.5 12137.2 12165.6 11104.1 11267.5 11321.4 11337.9 11605.2 649.0 808.9 822.5 823.3 823.4 789.8 815.7 816.9 822.9 824.5 853.5 855.7 858.7 859.3 864.2 843.9 846.8 848.5 848.6 850.1 623.4 625.1 625.8 626.4 628.8 11454.8 11547.4 11584.4 11614.9 11648.5 12133.9 12340.8 12732.7 13126.0 13271.8 9976.8 10035.0 10067.1 10341.7 10478.1 3222.4 3318.8 3322.5 3340.2 3365.6 45456.5 45580.8 47048.0 47231.0 47395.0 10128.9 10147.8 10191.1 10194.1 10232.8 16926.5 18418.1 18447.4 18457.0 18457.2 6718.5 6755.7 6763.5 6769.2 6795.0 3689.1 3709.3 3872.5 3875.6 3916.5 2824.8 2957.8 3046.8 3066.9 3070.7 541.8 551.8 559.6 563.9 564.1 506.7 540.3 593.7 611.1 614.8 7527.3 7616.0 7829.8 7862.3 8044.0 501.4 609.2 628.2 631.6 648.8 3617.3 3670.4 3675.8 3697.3 3787.9 45503.5 46347.8 46655.0 53923.0 54824.0 41935.0 42389.2 42728.8 42873.0 43460.3 38728.6 39687.4 40554.6 40906.6 41799.6 7851.3 7851.8 7919.0 7931.4 8197.3 26716.6 26967.9 27031.5 27441.2 27641.4 34977.5 36593.5 38848.8 39309.2 39422.6 10460.5 10567.2 10808.8 11003.4 11093.4 11921.4 12082.5 12130.6 12177.4 12454.1 11184.3 11460.5 11589.9 11970.3 11981.2 11145.9 11214.7 11585.2 11861.5 11875.9 9503.3 10961.7 11043.7 11427.5 11438.6 9335.3 9491.6 9612.2 9613.4 9628.9 8505.2 8704.4 9268.9 9777.9 10157.2 00:03:00 INFO - PROCESS | 7224 | -------- Summary: end -------- 00:03:00 INFO - PROCESS | 7224 | 00:03:01 INFO - TEST-INFO | 7224: exit 0 00:03:01 INFO - TEST-OK | dromaeo_css | took 1113999ms 00:03:01 INFO - TEST-START | kraken 00:03:01 INFO - operating with platform_type : linux_ 00:03:01 INFO - Initialising browser for kraken test... 00:03:01 INFO - TEST-INFO | started process 7457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOHBpv/profile http://localhost:51024/getInfo.html) 00:03:04 INFO - PROCESS | 7457 | 00:03:04 INFO - PROCESS | 7457 | (process:7523): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:03:05 INFO - PROCESS | 7457 | 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] 00:03:05 INFO - PROCESS | 7457 | __metrics Screen width/height:1600/1200 00:03:05 INFO - PROCESS | 7457 | colorDepth:24 00:03:05 INFO - PROCESS | 7457 | Browser inner width/height: 1024/697 00:03:05 INFO - PROCESS | 7457 | __metrics 00:03:06 ERROR - PROCESS | 7457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 00:03:06 INFO - TEST-INFO | 7457: exit 0 00:03:06 INFO - Browser initialized. 00:03:06 INFO - Running cycle 1/1 for kraken test... 00:03:06 INFO - TEST-INFO | started process 7574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOHBpv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:03:08 INFO - PROCESS | 7574 | 00:03:08 INFO - PROCESS | 7574 | (process:7633): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:03:18 INFO - PROCESS | 7574 | RSS: Main: 164147200 00:03:18 INFO - PROCESS | 7574 | 00:03:21 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection) 00:03:22 INFO - PROCESS | 7574 | RSS: Main: 167510016 00:03:22 INFO - PROCESS | 7574 | 00:03:25 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-dft) 00:03:25 INFO - PROCESS | 7574 | RSS: Main: 170696704 00:03:25 INFO - PROCESS | 7574 | 00:03:28 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-fft) 00:03:29 INFO - PROCESS | 7574 | RSS: Main: 163045376 00:03:29 INFO - PROCESS | 7574 | 00:03:31 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator) 00:03:32 INFO - PROCESS | 7574 | RSS: Main: 164073472 00:03:32 INFO - PROCESS | 7574 | 00:03:34 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:03:35 INFO - PROCESS | 7574 | RSS: Main: 164306944 00:03:35 INFO - PROCESS | 7574 | 00:03:38 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom) 00:03:39 INFO - PROCESS | 7574 | RSS: Main: 163975168 00:03:39 INFO - PROCESS | 7574 | 00:03:42 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate) 00:03:43 INFO - PROCESS | 7574 | RSS: Main: 163708928 00:03:43 INFO - PROCESS | 7574 | 00:03:46 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial) 00:03:46 INFO - PROCESS | 7574 | RSS: Main: 164614144 00:03:46 INFO - PROCESS | 7574 | 00:03:48 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:03:49 INFO - PROCESS | 7574 | RSS: Main: 164868096 00:03:49 INFO - PROCESS | 7574 | 00:03:50 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:03:51 INFO - PROCESS | 7574 | RSS: Main: 164839424 00:03:51 INFO - PROCESS | 7574 | 00:03:53 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:03:54 INFO - PROCESS | 7574 | RSS: Main: 165167104 00:03:54 INFO - PROCESS | 7574 | 00:03:57 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:03:57 INFO - PROCESS | 7574 | RSS: Main: 165363712 00:03:57 INFO - PROCESS | 7574 | 00:04:00 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:04:01 INFO - PROCESS | 7574 | RSS: Main: 165400576 00:04:01 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51024/tests/kraken/driver.html?testName=ai-astar) 00:04:03 INFO - PROCESS | 7574 | RSS: Main: 167006208 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | __start_tp_report 00:04:03 INFO - PROCESS | 7574 | _x_x_mozilla_page_load 00:04:03 INFO - PROCESS | 7574 | _x_x_mozilla_page_load_details 00:04:03 INFO - PROCESS | 7574 | |i|pagename|runs| 00:04:03 INFO - PROCESS | 7574 | |0;ai-astar;114;108;114;114;115;130;127;115;113;114 00:04:03 INFO - PROCESS | 7574 | |1;audio-beat-detection;165;135;170;194;134;156;158;134;185;140 00:04:03 INFO - PROCESS | 7574 | |2;audio-dft;162;165;166;174;165;162;162;166;165;163 00:04:03 INFO - PROCESS | 7574 | |3;audio-fft;75;73;78;166;76;78;75;77;152;74 00:04:03 INFO - PROCESS | 7574 | |4;audio-oscillator;95;94;151;95;94;94;150;95;93;146 00:04:03 INFO - PROCESS | 7574 | |5;imaging-gaussian-blur;116;117;118;118;118;117;117;118;118;117 00:04:03 INFO - PROCESS | 7574 | |6;imaging-darkroom;147;147;150;151;149;147;147;149;148;148 00:04:03 INFO - PROCESS | 7574 | |7;imaging-desaturate;96;96;96;96;96;97;96;96;96;97 00:04:03 INFO - PROCESS | 7574 | |8;json-parse-financial;66;65;68;65;65;68;66;84;63;64 00:04:03 INFO - PROCESS | 7574 | |9;json-stringify-tinderbox;64;63;64;64;64;64;64;70;64;65 00:04:03 INFO - PROCESS | 7574 | |10;stanford-crypto-aes;84;86;88;84;85;85;93;83;87;84 00:04:03 INFO - PROCESS | 7574 | |11;stanford-crypto-ccm;144;139;143;156;144;138;143;141;172;140 00:04:03 INFO - PROCESS | 7574 | |12;stanford-crypto-pbkdf2;177;173;178;175;182;170;173;171;180;172 00:04:03 INFO - PROCESS | 7574 | |13;stanford-crypto-sha256-iterative;73;73;72;73;74;71;72;70;73;72 00:04:03 INFO - PROCESS | 7574 | __end_tp_report 00:04:03 INFO - PROCESS | 7574 | __start_cc_report 00:04:03 INFO - PROCESS | 7574 | _x_x_mozilla_cycle_collect,921 00:04:03 INFO - PROCESS | 7574 | __end_cc_report 00:04:03 INFO - PROCESS | 7574 | __startTimestamp1460617443565__endTimestamp 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | ------- Summary: start ------- 00:04:03 INFO - PROCESS | 7574 | Number of tests: 14 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#0] ai-astar Cycles:10 Average:116.40 Median:114.50 stddev:6.72 (5.9%) stddev-sans-first:7.07 00:04:03 INFO - PROCESS | 7574 | Values: 114.0 108.0 114.0 114.0 115.0 130.0 127.0 115.0 113.0 114.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:161.50 stddev:21.65 (13.4%) stddev-sans-first:22.77 00:04:03 INFO - PROCESS | 7574 | Values: 165.0 135.0 170.0 194.0 134.0 156.0 158.0 134.0 185.0 140.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.56 (2.2%) stddev-sans-first:3.61 00:04:03 INFO - PROCESS | 7574 | Values: 162.0 165.0 166.0 174.0 165.0 162.0 162.0 166.0 165.0 163.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:35.29 (46.7%) stddev-sans-first:36.87 00:04:03 INFO - PROCESS | 7574 | Values: 75.0 73.0 78.0 166.0 76.0 78.0 75.0 77.0 152.0 74.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.00 stddev:26.47 (28.2%) stddev-sans-first:27.46 00:04:03 INFO - PROCESS | 7574 | Values: 95.0 94.0 151.0 95.0 94.0 94.0 150.0 95.0 93.0 146.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 00:04:03 INFO - PROCESS | 7574 | Values: 116.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.42 (1.0%) stddev-sans-first:1.42 00:04:03 INFO - PROCESS | 7574 | Values: 147.0 147.0 150.0 151.0 149.0 147.0 147.0 149.0 148.0 148.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:04:03 INFO - PROCESS | 7574 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:6.04 (9.2%) stddev-sans-first:6.39 00:04:03 INFO - PROCESS | 7574 | Values: 66.0 65.0 68.0 65.0 65.0 68.0 66.0 84.0 63.0 64.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.00 stddev:1.96 (3.1%) stddev-sans-first:2.06 00:04:03 INFO - PROCESS | 7574 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 64.0 70.0 64.0 65.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.92 (3.4%) stddev-sans-first:3.02 00:04:03 INFO - PROCESS | 7574 | Values: 84.0 86.0 88.0 84.0 85.0 85.0 93.0 83.0 87.0 84.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:143.50 stddev:10.41 (7.3%) stddev-sans-first:11.02 00:04:03 INFO - PROCESS | 7574 | Values: 144.0 139.0 143.0 156.0 144.0 138.0 143.0 141.0 172.0 140.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:176.00 stddev:4.01 (2.3%) stddev-sans-first:4.20 00:04:03 INFO - PROCESS | 7574 | Values: 177.0 173.0 178.0 175.0 182.0 170.0 173.0 171.0 180.0 172.0 00:04:03 INFO - PROCESS | 7574 | 00:04:03 INFO - PROCESS | 7574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 00:04:03 INFO - PROCESS | 7574 | Values: 73.0 73.0 72.0 73.0 74.0 71.0 72.0 70.0 73.0 72.0 00:04:03 INFO - PROCESS | 7574 | -------- Summary: end -------- 00:04:03 INFO - PROCESS | 7574 | 00:04:04 INFO - TEST-INFO | 7574: exit 0 00:04:04 INFO - TEST-OK | kraken | took 63203ms 00:04:04 INFO - SUITE-END | took 1177s 00:04:04 INFO - Completed test suite (00:19:37) 00:04:04 INFO - javascript benchmark 00:04:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.6716660417446, 2707.12018593957, 2745.629340039094, 2759.0757096372713, 2764.1431156341537, 4652.488226295105, 4673.929891051633, 4674.953250467494, 4676.321933319671, 4719.480857105716, 4633.814647414099, 4767.594754445876, 4770.809167633299, 4840.322354870321, 4847.200211965031, 4333.285007973681, 4402.273624851896, 4417.491988421324, 4422.71252368595, 4423.51341352451, 575.7333819623973, 4271.850485233017, 4307.741535507864, 4390.209762242795, 4392.9560704393025, 4307.353896915456, 4321.9135617287475, 4327.632151267146, 4344.022594916134, 4399.956000439986, 4340.131973605292, 4349.84775532858, 4352.347147927804, 4356.651467882593, 4388.341748737683, 4321.395004699345, 4379.036611945398, 4385.583369579885, 4389.714668546534, 4428.0, 4648.395708557866, 4660.300954856764, 4664.067186562667, 4671.27595222741, 4699.177643912301, 4976.552110310089, 4986.152354099811, 5095.082885080684, 5107.846764597068, 5118.820841270575, 5082.059818933509, 5083.186690129599, 5094.490550944913, 5119.411267704225, 5139.460356662571, 4717.95282047182, 4725.149473094842, 4729.95270047302, 4735.526447355306, 4763.0, 5093.770780314895, 5144.38267407906, 5151.304573882478, 5201.557867581298, 5229.163333866639, 4942.703437793743, 4964.726940018334, 4965.702057876539, 4973.254011898244, 5018.372703412074, 5058.772355244023, 5059.06407314648, 5060.746962651852, 5072.137736584789, 5133.25567792668, 5021.153750435504, 5035.144025515598, 5078.568321692697, 5111.437741848394, 5133.897322053538, 4978.128827455181, 4984.102861484895, 4990.351254336913, 5007.824726134568, 5053.837617347957, 4237.555056719062, 4286.935695964563, 4287.506936702257, 4296.097819457948, 4328.264195086843, 3691.9077023074638, 3739.457778622085, 3777.036855601804, 3803.980980095137, 3844.4809950656304, 4290.849820256276, 4294.334378171388, 4335.458067741532, 4372.672049596293, 4381.737095774264, 5031.295618613397, 5033.496650335011, 5035.395752509649, 5037.4458809530925, 5038.571721403649, 4510.503844577094, 4512.097580483916, 4550.931736023962, 4573.49691533931, 4596.931046034312, 4565.840195593139, 4570.268756998864, 4575.588197062214, 4620.099080679235, 4623.12160689468, 4812.25410061441, 4836.516348365276, 4846.055019271208, 4858.392700912386, 4871.3667223260745, 5147.9227811583605, 5164.457731938092, 5164.9741751291, 5172.120739474223, 5208.9321689052895, 4924.482929292372, 4925.704457732548, 4938.185199442196, 4940.456549779449, 4990.076835785391, 4807.879803004953, 4982.501749824988, 5074.2642316864585, 5088.262201980618, 5109.770060347368, 5151.433342332415, 5158.922616160686, 5162.328897243335, 5175.0, 5176.9741151294, 4938.728369939688, 4984.302197692254, 4985.850424487271, 5007.198848184273, 5019.0965626187635, 4764.76176191196, 4937.086638971802, 4982.775775090057, 5006.424261210008, 5048.5203905628905, 4887.315775791463, 4896.877578060577, 4897.534734200245, 4924.63065270099, 4942.184539550934, 4955.82654607087, 4990.850274491771, 4997.125503037027, 4999.250112483157, 5064.139096353555, 4803.735794531194, 4879.56083952446, 4916.434610019894, 4919.901601967869, 4981.078500477423], "value": 4648.876490331922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.7474548881014, 582.9825105246842, 597.2415032908209, 597.7489454429141, 619.3868070610098, 33086.17284567887, 34202.828985855034, 34227.31545369091, 34232.1441963951, 34275.82862085689, 34422.0, 34612.30775384491, 34631.307373852505, 34752.0, 34881.82559087201, 7392.482526223166, 7627.54234745917, 7644.120926093487, 7648.0, 7670.386369090459, 7516.736914208004, 7788.221177882223, 7789.636813557633, 7806.804829879242, 7808.375329973617, 7713.112992005907, 7794.0, 7856.057273127232, 7858.29275365217, 7866.68533258669, 7717.0, 7722.884156737653, 7806.921930780704, 7818.648160832719, 7826.217378262185, 7746.690132394698, 7836.804079897991, 7846.333061689763, 7855.0, 7876.645550950221, 29622.70377296221, 34889.12777180565, 35037.47443788345, 35173.472397914054, 35233.47149792755, 2880.7119288071026, 2946.337074158297, 3044.9543256850943, 3094.226443389153, 3166.9841650791827, 26995.0, 27090.864545677145, 27414.314642133908, 27698.723012769817, 27711.445771084665, 2980.210244285266, 2990.5065664165386, 3014.125903487986, 3019.1999120233154, 3073.031994921615, 237331.0, 242388.78805606035, 242921.0, 243186.0, 243219.7585181101, 58088.128678069865, 58393.124103138485, 58875.0, 59025.40974590285, 59178.40821591729, 59370.0, 61715.38284617096, 63276.68361658162, 63645.68177159177, 63799.6810015947, 14214.360353784105, 14283.857161428252, 14367.281635918162, 14431.35058922351, 14443.49447769344, 10608.575656973635, 10658.946705266579, 10717.678469645924, 10757.677269681923, 10767.6231331903, 19035.524111897314, 19063.618727625646, 19146.138423770964, 19295.90352048231, 19812.306569270007, 7556.962215188999, 7675.117361503499, 7686.57723825195, 7773.844523109619, 7779.105402878628, 872.9650813967497, 978.5938835383237, 989.6486747204639, 1015.5156496619958, 1022.7340891368298, 28313.71686283152, 28451.71548284532, 29368.706312936596, 29478.263043423656, 29504.557431638543, 975.7219192530094, 995.7908839143716, 1005.8139244239838, 1040.3341861208833, 1078.2182917384832, 14930.925345373204, 15244.618884527754, 15320.923395382952, 15497.922510387376, 15723.0, 348803.0, 354360.0, 357539.0, 357724.0, 358790.0, 48549.5145048545, 49332.0, 49338.50661493411, 49445.50554494481, 49452.50547494479, 1231.870653581379, 1256.5664845628244, 1261.6593519749615, 1265.7531781302741, 1390.7009992851586, 26668.866655667374, 27719.0, 27736.44527109406, 28609.427811443238, 28786.0, 42861.3570796432, 42937.14125717406, 43054.78472607617, 43352.78323608362, 43393.3490997629, 311519.0, 312641.0, 313240.0, 314345.0, 315420.0, 26089.08688195904, 26708.332291692084, 26795.732042680105, 41131.38302925519, 42632.36051459169, 41610.16779664329, 41902.37146442867, 42018.36972445354, 42112.36831447592, 42801.143977120904, 35650.643493564734, 36028.0, 36084.81957590195, 36299.81850090733, 36458.0, 33998.66001339955, 34079.82960085184, 34263.65736342605, 34326.48510272298, 34778.30443391067, 35137.64862351446, 35302.29395412129, 36781.816090920445, 37109.257814844095, 38361.0, 29546.852265739395, 31806.84096579502, 31842.68157318397, 32154.0, 32326.83836580802, 25063.373415664755, 25122.12072577451, 25167.87416062908, 25539.36151596225, 25686.357841054123], "value": 17549.32742618486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.52895203375857, 385.39108209029735, 391.5008364335472, 394.56794809683385, 396.1403753854136, 15389.384424623016, 16149.677006459864, 16631.417900373475, 16638.41935016173, 16652.08413537258, 16188.514344569652, 16384.098874561896, 16401.507954761375, 16583.83416165838, 16694.165291735426, 5103.948960510394, 5248.448912864133, 5310.07073762092, 5336.573074154077, 5347.385050719159, 3653.8903832885057, 5756.222909907172, 6119.724612392431, 6135.447809697126, 6137.232845894263, 4941.505849415065, 6058.666773327465, 6080.300765411968, 6097.115918191859, 6113.602615829979, 5178.974105129469, 5190.71451070191, 5200.557952573998, 5202.479752024805, 5208.531232189083, 4925.990172014728, 5272.657277276965, 5305.893882122375, 5307.9734601326745, 5336.653117547347, 18309.45071647853, 18735.625287494175, 19028.048597570203, 19051.237950481966, 19332.516687082796, 1788.3963812916982, 1868.1499917537487, 1916.808319168086, 2200.4388880835286, 2469.3085935937966, 8704.086070962585, 8808.0, 8876.511791851446, 8942.821143577157, 9044.77388065297, 1749.1691446562781, 1760.7622970898892, 1773.804881463038, 1783.9197236124405, 1833.5324492254524, 67431.0, 69178.0, 70052.29947700509, 70822.64588677076, 71577.0, 9387.202087822476, 9643.9035609643, 10286.485675716185, 10290.861138065648, 10307.94846025765, 14573.344199511048, 14584.0, 14615.342309596093, 14624.341904614104, 14655.413783448756, 6990.720371185197, 7176.533525320941, 7299.941508481241, 7417.517861338995, 7445.143808461988, 7043.436525077981, 7050.471214658921, 7081.150261968493, 7223.566586004857, 7238.782836514913, 4356.3683265926265, 4408.933865992013, 4418.1163767246035, 4440.089781594766, 4508.661850361236, 1680.983190168107, 3159.4470967580583, 3218.8229647369153, 3259.3436349375183, 3512.455569386749, 888.2627419242014, 934.9485778282124, 937.3579098317674, 966.7196513011288, 972.6206779356057, 16292.918535407247, 16673.6665266694, 17044.829551704574, 17310.65378692419, 17375.826241737675, 909.1408618855119, 915.4004127296631, 940.1022023967095, 967.4002118686459, 1000.6297669862198, 9338.20625246848, 9528.380655257386, 9535.666251681158, 9652.951735241279, 9818.969008254173, 388430.0, 393500.0, 396590.0, 401676.0, 403038.0, 74274.0, 75609.0, 76429.61785191039, 76973.61513192399, 78252.21747782563, 980.4901451245455, 988.1304452082265, 1025.2105878473533, 1026.9435181064964, 1033.34382667007, 14850.554483365084, 14971.625709356918, 14982.40070397172, 15108.697826043197, 15367.30847111905, 32632.184195395304, 32721.18197045093, 34348.48477272793, 34561.65438345585, 34700.13249668779, 45018.77490612526, 45129.774351128035, 47154.292685609056, 47815.521844781106, 48629.513704863915, 4717.622590192845, 5401.270828438111, 5661.716914154358, 6544.640044797582, 6944.652767361713, 10465.029111172436, 11649.534018639159, 11775.882241177822, 11777.116716246144, 11786.58746943853, 10239.795204095728, 10248.59005639796, 10280.588776448858, 10354.844677329695, 10451.529681164518, 10213.74465638365, 10283.0, 10293.588256469957, 10304.639337623148, 10392.16862650971, 10234.692959211236, 10480.842787358044, 10568.365898046142, 10617.893821062, 10745.570177192825, 6948.826279343057, 7037.472189585904, 7167.354938055391, 7168.139823221247, 7214.2785721427435, 9637.37357071788, 10341.793164136825, 10437.739056523647, 10535.937265870958, 10761.461926903467], "value": 8297.296942039111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.5019918128241, 1480.4596322342345, 1605.3899518183096, 1769.0535563473545, 1782.7504149419083, 6887.931120688791, 7572.697092116316, 7621.58081305528, 7865.882011769821, 7891.526508409499, 7722.884156737639, 7736.34241089508, 7771.92228077719, 7773.572453515055, 7786.065672119354, 2274.2608652188023, 2299.8620082795087, 2301.861888286708, 2302.5049614332916, 2304.6197377432704, 2232.096001119541, 2235.0, 2299.2872209615075, 2303.170858490942, 2303.928673166977, 2242.6299660555987, 2245.9101635934626, 2281.7946384825364, 2311.3181611424584, 2317.8841057947034, 2225.7996780289773, 2232.363776323748, 2241.7309922809204, 2242.091952759135, 2249.6850440938283, 2186.8469207155504, 2201.1305534313856, 2212.203606701586, 2218.201447478906, 2232.5088480534255, 7927.048754149481, 7968.442209045369, 7976.6809327626825, 7992.080910695228, 7999.640016199285, 4610.101030299093, 4693.507181745902, 4717.575418212377, 4777.5222477752295, 4778.259369797687, 2898.2754311422145, 3000.7899447038717, 3105.2392163919985, 3119.485284927984, 3141.3717256548553, 900.7027680865299, 904.452806052342, 914.6295750221171, 914.8856392950881, 930.3208657679932, 10360.481975901175, 10469.31949423285, 10475.685729428129, 10482.63310784119, 10506.632267870664, 4183.1215444756335, 4192.350185721157, 4320.719153255091, 4348.717333373321, 4450.710703804242, 8977.461352318882, 8986.68546600866, 8992.595333210022, 8996.415233009964, 9008.504532250658, 4715.717056976592, 4734.55021772931, 4771.284307353924, 4789.4971028042255, 4795.184818580849, 3772.0946972726347, 4174.0, 4243.193793179286, 4331.220380331571, 4351.108022855307, 3715.16408808016, 3717.4052151655605, 3754.5682246541996, 3805.1058001369656, 3807.2575847709986, 1216.738401243737, 1248.2323371126693, 1274.8980081593636, 1279.7632437998814, 1287.1440492072668, 720.8882623193414, 810.2707563193055, 882.1399135842502, 909.8180363927241, 910.9635614575343, 5267.236250743621, 5458.836234912879, 5472.616916815864, 5508.44915508454, 5509.256250406224, 853.2448782827242, 872.31959071924, 937.1986951156799, 960.4477425480377, 962.138885697297, 3884.76691398517, 3896.649301562873, 3933.547642021147, 3948.1511475033008, 3953.87314615339, 9300.11648893354, 9551.379160354554, 9650.420974741539, 9657.806843863224, 9834.114929656365, 9399.060093990547, 9452.90547094534, 9515.429074255568, 9573.32986690939, 9590.232781377474, 7218.8917166242545, 7253.927460725326, 7417.221191774786, 7429.62851857405, 7441.590712510864, 5484.862878428071, 5514.889702206014, 5586.553075754011, 5700.458456446631, 5764.394738552559, 8851.601677924638, 8867.068957759342, 8892.421992570462, 8935.061818508962, 8993.055729148346, 8755.781105472413, 8858.202761751474, 9062.909370906207, 9117.77205569866, 9193.724188274362, 6242.781502647385, 6771.830704232433, 6893.448524118159, 7046.506744528039, 7055.858882822417, 7742.264484873928, 7749.457537972513, 7773.37812974972, 7790.415718820997, 7822.4524283299625, 6808.693608787517, 6986.336298051677, 7028.297170282931, 7032.472564557576, 7103.325184107502, 6920.619365934922, 6947.062146610143, 6966.407855332353, 6986.266442023514, 7077.5753454792875, 6136.570440069152, 6354.23749150105, 6398.936010639834, 6402.487800975818, 6457.870842583028, 4503.189425903369, 4615.907681846412, 4671.135839869635, 4723.574878260973, 4737.407824021997, 4851.781669824796, 4906.435759887516, 4919.065377578248, 4935.777889994887, 4981.402231732215], "value": 4250.3625915922075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.64423845293277, 318.9744820414367, 326.25939118201677, 329.93401319736057, 332.390064232134, 5235.424103348633, 5320.547753440953, 5325.20121981703, 5327.7336133193285, 5339.492748188925, 5246.878107526016, 5281.18141688038, 5282.788688452467, 5293.655912365703, 5302.708351040691, 3929.2337994091163, 3992.0, 4123.814428350732, 4128.3601041838565, 4130.607592278744, 4113.786433002271, 4120.608542188503, 4136.214119317335, 4136.97931510342, 4158.708890377675, 4096.446979657752, 4138.0, 4143.689223308249, 4145.502539695241, 4149.3775933609895, 4039.9798001009954, 4098.877033688979, 4117.711760176789, 4120.340745480738, 4140.875773726793, 3610.5667319921513, 3616.8372423241017, 3623.601403845575, 3633.182533929871, 3633.65480279373, 5020.322256495399, 5050.141475949097, 5056.393232812049, 5064.139096353629, 5081.568066714333, 4592.714040068786, 4751.0, 4756.500567440438, 4766.428028636551, 4779.091972525209, 5515.172724091419, 5517.944820551783, 5527.296711203503, 5545.3086808523385, 5546.084895992157, 3972.741771784825, 3978.900527486836, 3981.124152686404, 3984.342583473723, 3985.900352491182, 5610.186522954149, 5749.540036797046, 5796.5072968797285, 5803.245578074823, 5806.912896306559, 4052.756834589934, 4064.776437295918, 4090.8159132839096, 4091.6931230157857, 4093.2222877653153, 4141.7722025288895, 4142.357934520094, 4151.647109995623, 4155.148194620096, 4168.041350489404, 4691.0, 4717.386739723814, 4722.244440889442, 4733.0, 4735.763211839394, 5371.382291036581, 5521.806736764194, 5545.667259964334, 5558.221848941152, 5577.581681373913, 1436.8778653814543, 1457.6880807273326, 1462.1300326305832, 1466.4207637982936, 1467.4423718986716, 916.9862452063225, 971.140540621555, 995.1889210293588, 1008.6318493749728, 1035.1460045462522, 4859.538343857328, 4904.2643603459765, 4949.925751113737, 4953.578945789648, 4969.0807200668, 5706.0, 5716.342620598602, 5729.28383952006, 5730.426957304319, 5743.913841292384, 4740.881477963078, 4893.9021219576125, 4908.877278068006, 4923.852284431473, 5036.622253331015, 3054.9694503054684, 3067.0, 3077.7383922366403, 3094.3501864608684, 3095.613048368954, 5477.616566840283, 5479.369872464717, 5495.642783219078, 5497.587680923947, 5508.641938274, 5757.395473475225, 5857.941420585825, 5898.0, 5898.820235952827, 5935.169076329317, 5463.31708536433, 5479.698616576047, 5510.8071217507195, 5526.143447765683, 5531.612787104945, 5673.801416950387, 5777.133429985536, 5792.073268277224, 5801.071828507418, 5826.912596311144, 5680.869673872298, 5696.800611978727, 5703.20155178267, 5714.20001199824, 5716.657000579812, 5516.310461192351, 5533.2253484513, 5535.861603459945, 5541.335039795089, 5564.054110801255, 3941.7240793144206, 4020.175863947942, 4040.616141466556, 4045.130296986162, 4047.372657238133, 5793.131030345482, 5808.128780682931, 5815.41845815415, 5822.883542329215, 5841.094630332305, 5627.155926611041, 5628.437156284339, 5633.6619802811965, 5634.802781902614, 5637.701944362594, 5447.291852059207, 5526.143447765603, 5607.943920560742, 5611.80358687444, 5612.635178713534, 5167.6641018333685, 5444.292242008513, 5450.427705090909, 5450.700211488248, 5461.290032295935, 5389.380221274603, 5578.609497335147, 5608.915866262091, 5622.0, 5651.0, 5425.403205647454, 5459.416769137065, 5494.478024587817, 5497.3952865184, 5520.006398848085], "value": 4210.844992812116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9190101237346, 728.5191773429531, 757.4697711601876, 789.1556035042503, 801.6953557648096, 11221.214514983954, 11942.522299108035, 12096.516139354415, 12137.15039947204, 12165.57420490283, 11104.056790061728, 11267.549298028069, 11321.433928303593, 11337.886621133786, 11605.245659032156, 649.0426620734427, 808.9029316482031, 822.4859462835727, 823.3372135430976, 823.423603477565, 789.7670187294761, 815.6981916690833, 816.9387295952797, 822.8847961285425, 824.5258976088772, 853.5092321914892, 855.700504823313, 858.6608289725585, 859.3168431097262, 864.1790299215738, 843.8734189871507, 846.7883029242689, 848.4612271207797, 848.6138806842903, 850.0649285785648, 623.392192612204, 625.1185827982569, 625.7653379982506, 626.4424662050778, 628.8144997225829, 11454.770904581861, 11547.422628868522, 11584.42077896102, 11614.941925290319, 11648.534058637644, 12133.93933030338, 12340.81488777669, 12732.681682957907, 13126.0, 13271.800922986164, 9976.800463990752, 10035.0, 10067.093961543424, 10341.741456463573, 10478.10936070435, 3222.387746328214, 3318.7510936679605, 3322.5016247562817, 3340.1816554943953, 3365.562476878015, 45456.54543454589, 45580.772096139306, 47047.99999999966, 47231.0, 47395.0, 10128.898711012944, 10147.797044059225, 10191.082802547806, 10194.082532572103, 10232.846507302396, 16926.492205233862, 18418.07909604541, 18447.446576602455, 18457.0, 18457.1694273758, 6718.529702920749, 6755.695993680296, 6763.525805567304, 6769.153855768029, 6794.9660251699415, 3689.0592898810633, 3709.295233905549, 3872.53529576447, 3875.6124387561017, 3916.4516967624554, 2824.759895408913, 2957.822530648168, 3046.7562594992346, 3066.938661226763, 3070.7389871860696, 541.8130744893006, 551.7710150287586, 559.6138664321605, 563.9436056394328, 564.0889962710194, 506.683322923173, 540.348879600081, 593.6912805341199, 611.1077826373545, 614.7786796753165, 7527.3225409712295, 7615.961920190363, 7829.843403131906, 7862.33170180541, 8044.0, 501.3707796715172, 609.1654433426235, 628.1676778268812, 631.564220687724, 648.7859006527834, 3617.3127105849803, 3670.44943258508, 3675.7794532328144, 3697.2790305890094, 3787.886363409102, 45503.54496454993, 46347.768261158475, 46655.0, 53923.0, 54824.0, 41935.0, 42389.15221695549, 42728.78635606802, 42873.0, 43460.3480947786, 38728.612713873066, 39687.40468892969, 40554.594454055674, 40906.59093409088, 41799.58200418018, 7851.332636725942, 7851.764447066597, 7918.960405197937, 7931.444798864024, 8197.34421246287, 26716.599251010863, 26967.86516067407, 27031.45937081208, 27441.17676469709, 27641.44717105687, 34977.475337869444, 36593.45109823302, 38848.805755971036, 39309.2138157241, 39422.60577394189, 10460.529276182438, 10567.154627629618, 10808.837867432152, 11003.394813285026, 11093.44532773342, 11921.403929803648, 12082.516699331929, 12130.636080917586, 12177.391130443266, 12454.065945053975, 11184.328940263285, 11460.484278207667, 11589.942050289694, 11970.341631210018, 11981.22122062098, 11145.888541114486, 11214.66356009321, 11585.246958947642, 11861.525538978343, 11875.940620296844, 9503.334766566273, 10961.725956850823, 11043.668689939315, 11427.542898283975, 11438.599649012245, 9335.346525743133, 9491.620335186515, 9612.231021518402, 9613.423194608346, 9628.855567166358, 8505.23452889243, 8704.390692651454, 9268.907310926805, 9777.85333219988, 10157.238207134347], "value": 5919.237396239496, "unit": "score"}], "name": "dromaeo_css", "value": 6445.775449543247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 114.0, 115.0, 130.0, 127.0, 115.0, 113.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 135.0, 170.0, 194.0, 134.0, 156.0, 158.0, 134.0, 185.0, 140.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 166.0, 174.0, 165.0, 162.0, 162.0, 166.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 78.0, 166.0, 76.0, 78.0, 75.0, 77.0, 152.0, 74.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 151.0, 95.0, 94.0, 94.0, 150.0, 95.0, 93.0, 146.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 151.0, 149.0, 147.0, 147.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 65.0, 65.0, 68.0, 66.0, 84.0, 63.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 70.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 88.0, 84.0, 85.0, 85.0, 93.0, 83.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 143.0, 156.0, 144.0, 138.0, 143.0, 141.0, 172.0, 140.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 178.0, 175.0, 182.0, 170.0, 173.0, 171.0, 180.0, 172.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 74.0, 71.0, 72.0, 70.0, 73.0, 72.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1614.8, "alertThreshold": 2.0}]} 00:04:04 INFO - Return code: 0 00:04:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:04:04 ERROR - # TBPL SUCCESS # 00:04:04 INFO - Running post-action listener: _resource_record_post_action 00:04:04 INFO - Running post-run listener: _resource_record_post_run 00:04:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 348160; Write bytes: 293507072; Read time: 192; Write time: 196568 00:04:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10244096; Read time: 0; Write time: 2400 00:04:05 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 348160; Write bytes: 282816512; Read time: 192; Write time: 194168 00:04:05 INFO - Running post-run listener: _upload_blobber_files 00:04:05 INFO - Blob upload gear active. 00:04:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:04:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:04:06 INFO - (blobuploader) - INFO - Open directory for files ... 00:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:07 INFO - (blobuploader) - INFO - Done attempting. 00:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:07 INFO - (blobuploader) - INFO - Done attempting. 00:04:07 INFO - (blobuploader) - INFO - Iteration through files over. 00:04:07 INFO - Return code: 0 00:04:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:04:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:04:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3206eae6bec1ccd38a569d443c03e8183f75e1c31db6fc0f4d25aa52e9973030ce61139bac64eb8bcbc9c7783f67772866ef8e658a5ad2230b7fd9a10ac8037d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6ce39a71d350e46d90bab9c008eaaf66b9bbf462839b2adfbaa0ed840efc00fe37851e03d83e0b000dab80de5aeff2a4ebb7c49264fa849c2e303a2d413a097"} 00:04:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:04:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:04:07 INFO - Contents: 00:04:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3206eae6bec1ccd38a569d443c03e8183f75e1c31db6fc0f4d25aa52e9973030ce61139bac64eb8bcbc9c7783f67772866ef8e658a5ad2230b7fd9a10ac8037d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6ce39a71d350e46d90bab9c008eaaf66b9bbf462839b2adfbaa0ed840efc00fe37851e03d83e0b000dab80de5aeff2a4ebb7c49264fa849c2e303a2d413a097"} 00:04:07 INFO - Running post-run listener: copy_logs_to_upload_dir 00:04:07 INFO - Copying logs to upload dir... 00:04:07 INFO - mkdir: /builds/slave/test/build/upload/logs 00:04:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.126819 ========= master_lag: 66.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-14 00:05:14.717280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 00:05:14.720624) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 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/3206eae6bec1ccd38a569d443c03e8183f75e1c31db6fc0f4d25aa52e9973030ce61139bac64eb8bcbc9c7783f67772866ef8e658a5ad2230b7fd9a10ac8037d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6ce39a71d350e46d90bab9c008eaaf66b9bbf462839b2adfbaa0ed840efc00fe37851e03d83e0b000dab80de5aeff2a4ebb7c49264fa849c2e303a2d413a097"} build_url:https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/S3YBH1eXSqK-Nj3w1D65Ag/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/3206eae6bec1ccd38a569d443c03e8183f75e1c31db6fc0f4d25aa52e9973030ce61139bac64eb8bcbc9c7783f67772866ef8e658a5ad2230b7fd9a10ac8037d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6ce39a71d350e46d90bab9c008eaaf66b9bbf462839b2adfbaa0ed840efc00fe37851e03d83e0b000dab80de5aeff2a4ebb7c49264fa849c2e303a2d413a097"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 00:05:15.124070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 00:05:15.124407) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460613857.949413-2086033771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 00:05:15.143173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 00:05:15.143482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 00:05:15.143748) ========= ========= Total master_lag: 67.56 =========