builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1449439464.24 results: success (0) buildid: 20151206131030 builduid: ef0c5193a5d84720883cac61ec76a4a1 revision: 29e5fb8c86db75eafcc44dc607f7a00312ce0f47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.236924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.237371) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.237720) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.283971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.284303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.423779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.424075) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.487158) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.487478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.487870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.488180) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-06 14:04:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-06 14:04:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.700785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.701607) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.755164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:24.755521) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29e5fb8c86db75eafcc44dc607f7a00312ce0f47 --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 29e5fb8c86db75eafcc44dc607f7a00312ce0f47 --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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-06 14:04:25,662 truncating revision to first 12 chars 2015-12-06 14:04:25,662 Setting DEBUG logging. 2015-12-06 14:04:25,662 attempt 1/10 2015-12-06 14:04:25,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29e5fb8c86db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-06 14:04:26,163 unpacking tar archive at: fx-team-29e5fb8c86db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797125 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:25.568009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:25.568709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:25.579263) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:25.579744) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-06 14:04:25.580365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-06 14:04:25.580885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:26 INFO - MultiFileLogger online at 20151206 14:04:26 in /builds/slave/test 14:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:04:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:26 INFO - {'append_to_log': False, 14:04:26 INFO - 'base_work_dir': '/builds/slave/test', 14:04:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:26 INFO - 'branch': 'Fx-Team-Non-PGO', 14:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:26 INFO - 'config_files': ('talos/linux_config.py',), 14:04:26 INFO - 'default_actions': ('clobber', 14:04:26 INFO - 'read-buildbot-config', 14:04:26 INFO - 'download-and-extract', 14:04:26 INFO - 'populate-webroot', 14:04:26 INFO - 'create-virtualenv', 14:04:26 INFO - 'install', 14:04:26 INFO - 'run-tests'), 14:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:26 INFO - 'download_minidump_stackwalk': True, 14:04:26 INFO - 'download_symbols': 'ondemand', 14:04:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:26 INFO - 'installer_path': 'installer.exe', 14:04:26 INFO - 'log_level': 'info', 14:04:26 INFO - 'log_name': 'talos', 14:04:26 INFO - 'log_to_console': True, 14:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:26 INFO - 'opt_config_files': (), 14:04:26 INFO - 'pip_index': False, 14:04:26 INFO - 'sps_profile': False, 14:04:26 INFO - 'sps_profile_interval': 0, 14:04:26 INFO - 'suite': 'dromaeojs', 14:04:26 INFO - 'system_bits': '64', 14:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:26 INFO - 'title': 'talos-linux64-ix-048', 14:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:26 INFO - 'use_talos_json': True, 14:04:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:26 INFO - 'work_dir': 'build'} 14:04:26 INFO - ##### 14:04:26 INFO - ##### Running clobber step. 14:04:26 INFO - ##### 14:04:26 INFO - Running pre-action listener: _resource_record_pre_action 14:04:26 INFO - Running main action method: clobber 14:04:26 INFO - rmtree: /builds/slave/test/build 14:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running read-buildbot-config step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: read_buildbot_config 14:04:27 INFO - Using buildbot properties: 14:04:27 INFO - { 14:04:27 INFO - "properties": { 14:04:27 INFO - "buildnumber": 1181, 14:04:27 INFO - "product": "firefox", 14:04:27 INFO - "script_repo_revision": "production", 14:04:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:04:27 INFO - "repository": "", 14:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:04:27 INFO - "buildid": "20151206131030", 14:04:27 INFO - "slavename": "talos-linux64-ix-048", 14:04:27 INFO - "pgo_build": "False", 14:04:27 INFO - "basedir": "/builds/slave/test", 14:04:27 INFO - "project": "", 14:04:27 INFO - "platform": "ubuntu64_hw", 14:04:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:04:27 INFO - "slavebuilddir": "test", 14:04:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:04:27 INFO - "branch": "fx-team", 14:04:27 INFO - "repo_path": "integration/fx-team", 14:04:27 INFO - "stage_platform": "linux64", 14:04:27 INFO - "builduid": "ef0c5193a5d84720883cac61ec76a4a1", 14:04:27 INFO - "revision": "29e5fb8c86db75eafcc44dc607f7a00312ce0f47" 14:04:27 INFO - }, 14:04:27 INFO - "sourcestamp": { 14:04:27 INFO - "repository": "", 14:04:27 INFO - "hasPatch": false, 14:04:27 INFO - "project": "", 14:04:27 INFO - "branch": "fx-team-linux64-talos", 14:04:27 INFO - "changes": [ 14:04:27 INFO - { 14:04:27 INFO - "category": null, 14:04:27 INFO - "files": [ 14:04:27 INFO - { 14:04:27 INFO - "url": null, 14:04:27 INFO - "name": "https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:04:27 INFO - } 14:04:27 INFO - ], 14:04:27 INFO - "repository": "", 14:04:27 INFO - "rev": "29e5fb8c86db75eafcc44dc607f7a00312ce0f47", 14:04:27 INFO - "who": "dbaron@mozilla.com", 14:04:27 INFO - "when": 1449439317, 14:04:27 INFO - "number": 6896927, 14:04:27 INFO - "comments": "Merge mozilla-central to fx-team.", 14:04:27 INFO - "project": "", 14:04:27 INFO - "at": "Sun 06 Dec 2015 14:01:57", 14:04:27 INFO - "branch": "fx-team-linux64-talos", 14:04:27 INFO - "revlink": "", 14:04:27 INFO - "properties": [ 14:04:27 INFO - [ 14:04:27 INFO - "buildid", 14:04:27 INFO - "20151206131030", 14:04:27 INFO - "Change" 14:04:27 INFO - ], 14:04:27 INFO - [ 14:04:27 INFO - "builduid", 14:04:27 INFO - "ef0c5193a5d84720883cac61ec76a4a1", 14:04:27 INFO - "Change" 14:04:27 INFO - ], 14:04:27 INFO - [ 14:04:27 INFO - "pgo_build", 14:04:27 INFO - "False", 14:04:27 INFO - "Change" 14:04:27 INFO - ] 14:04:27 INFO - ], 14:04:27 INFO - "revision": "29e5fb8c86db75eafcc44dc607f7a00312ce0f47" 14:04:27 INFO - } 14:04:27 INFO - ], 14:04:27 INFO - "revision": "29e5fb8c86db75eafcc44dc607f7a00312ce0f47" 14:04:27 INFO - } 14:04:27 INFO - } 14:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running download-and-extract step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: download_and_extract 14:04:27 INFO - mkdir: /builds/slave/test/build/tests 14:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:27 INFO - https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/test_packages.json 14:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/test_packages.json 14:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:04:28 INFO - Downloaded 1302 bytes. 14:04:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:04:28 INFO - Using the following test package requirements: 14:04:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'jsshell-linux-x86_64.zip'], 14:04:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:28 INFO - https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:30 INFO - Downloaded 21849627 bytes. 14:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:31 INFO - Return code: 0 14:04:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:31 INFO - https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:35 INFO - Downloaded 21849627 bytes. 14:04:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:04:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:36 INFO - Return code: 0 14:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:36 INFO - https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:04:37 INFO - Downloaded 11132001 bytes. 14:04:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:04:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:04:37 INFO - Return code: 0 14:04:37 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')]} 14:04:37 INFO - https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:04:39 INFO - Downloaded 57705836 bytes. 14:04:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:39 INFO - mkdir: /builds/slave/test/properties 14:04:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:39 INFO - Contents: 14:04:39 INFO - build_url:https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:39 INFO - Running post-action listener: _resource_record_post_action 14:04:39 INFO - Running post-action listener: set_extra_try_arguments 14:04:39 INFO - ##### 14:04:39 INFO - ##### Running populate-webroot step. 14:04:39 INFO - ##### 14:04:39 INFO - Running pre-action listener: _resource_record_pre_action 14:04:39 INFO - Running main action method: populate_webroot 14:04:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:04:39 INFO - '../fennec_ids.txt'], 14:04:39 INFO - 'tests': ['tcheck2']}, 14:04:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:39 INFO - '--tppagecycles', 14:04:39 INFO - '7'], 14:04:39 INFO - 'tests': ['tsvgm']}}, 14:04:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'tests': ['damp', 'tps']}, 14:04:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['damp', 'tps']}, 14:04:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:39 INFO - 'other': {'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'other_l64': {'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:39 INFO - 'ts_paint', 14:04:39 INFO - 'tpaint', 14:04:39 INFO - 'sessionrestore', 14:04:39 INFO - 'sessionrestore_no_auto_restore']}, 14:04:39 INFO - 'svgr': {'tests': ['tsvgx', 14:04:39 INFO - 'tsvgr_opacity', 14:04:39 INFO - 'tart', 14:04:39 INFO - 'tscrollx', 14:04:39 INFO - 'cart']}, 14:04:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['tsvgx', 14:04:39 INFO - 'tsvgr_opacity', 14:04:39 INFO - 'tart', 14:04:39 INFO - 'tscrollx', 14:04:39 INFO - 'cart']}, 14:04:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'tests': ['tp5o']}, 14:04:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'talos_options': ['--e10s'], 14:04:39 INFO - 'tests': ['tp5o']}, 14:04:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'talos_options': ['--xperf_path', 14:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:39 INFO - 'tests': ['tp5n']}, 14:04:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:39 INFO - 'talos_options': ['--e10s', 14:04:39 INFO - '--xperf_path', 14:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:39 INFO - 'tests': ['tp5n']}}, 14:04:39 INFO - 'talos.zip': {'path': '', 14:04:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:39 INFO - Running post-action listener: _resource_record_post_action 14:04:39 INFO - ##### 14:04:39 INFO - ##### Running create-virtualenv step. 14:04:39 INFO - ##### 14:04:39 INFO - Running pre-action listener: _resource_record_pre_action 14:04:39 INFO - Running main action method: create_virtualenv 14:04:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04:39 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 14:04:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:39 INFO - Using real prefix '/usr' 14:04:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:42 INFO - Installing pip.................done. 14:04:42 INFO - Return code: 0 14:04:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:42 INFO - Using env: {'DISPLAY': ':0', 14:04:42 INFO - 'HOME': '/home/cltbld', 14:04:42 INFO - 'LANG': 'en_US.UTF-8', 14:04:42 INFO - 'LANGUAGE': 'en_US:en', 14:04:42 INFO - 'LOGNAME': 'cltbld', 14:04:42 INFO - 'MAIL': '/var/mail/cltbld', 14:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:42 INFO - 'MOZ_NO_REMOTE': '1', 14:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:42 INFO - 'NO_EM_RESTART': '1', 14:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:42 INFO - 'PWD': '/builds/slave/test', 14:04:42 INFO - 'SHELL': '/bin/bash', 14:04:42 INFO - 'SHLVL': '1', 14:04:42 INFO - 'TERM': 'linux', 14:04:42 INFO - 'TMOUT': '86400', 14:04:42 INFO - 'USER': 'cltbld', 14:04:42 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:42 INFO - '_': '/tools/buildbot/bin/python'} 14:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:42 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 14:04:42 INFO - Cleaning up... 14:04:42 INFO - Return code: 0 14:04:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:42 INFO - Using env: {'DISPLAY': ':0', 14:04:42 INFO - 'HOME': '/home/cltbld', 14:04:42 INFO - 'LANG': 'en_US.UTF-8', 14:04:42 INFO - 'LANGUAGE': 'en_US:en', 14:04:42 INFO - 'LOGNAME': 'cltbld', 14:04:42 INFO - 'MAIL': '/var/mail/cltbld', 14:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:42 INFO - 'MOZ_NO_REMOTE': '1', 14:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:42 INFO - 'NO_EM_RESTART': '1', 14:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:42 INFO - 'PWD': '/builds/slave/test', 14:04:42 INFO - 'SHELL': '/bin/bash', 14:04:42 INFO - 'SHLVL': '1', 14:04:42 INFO - 'TERM': 'linux', 14:04:42 INFO - 'TMOUT': '86400', 14:04:42 INFO - 'USER': 'cltbld', 14:04:42 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:42 INFO - '_': '/tools/buildbot/bin/python'} 14:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:42 INFO - Downloading/unpacking psutil>=0.7.1 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:04:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:44 INFO - Installing collected packages: psutil 14:04:44 INFO - Running setup.py install for psutil 14:04:44 INFO - building 'psutil._psutil_linux' extension 14:04:44 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 14:04:44 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 14:04:44 INFO - building 'psutil._psutil_posix' extension 14:04:44 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 14:04:44 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 14:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:44 INFO - Successfully installed psutil 14:04:44 INFO - Cleaning up... 14:04:44 INFO - Return code: 0 14:04:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:04:44 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')]} 14:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:44 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')]} 14:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:44 INFO - Using env: {'DISPLAY': ':0', 14:04:44 INFO - 'HOME': '/home/cltbld', 14:04:44 INFO - 'LANG': 'en_US.UTF-8', 14:04:44 INFO - 'LANGUAGE': 'en_US:en', 14:04:44 INFO - 'LOGNAME': 'cltbld', 14:04:44 INFO - 'MAIL': '/var/mail/cltbld', 14:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:44 INFO - 'MOZ_NO_REMOTE': '1', 14:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:44 INFO - 'NO_EM_RESTART': '1', 14:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:44 INFO - 'PWD': '/builds/slave/test', 14:04:44 INFO - 'SHELL': '/bin/bash', 14:04:44 INFO - 'SHLVL': '1', 14:04:44 INFO - 'TERM': 'linux', 14:04:44 INFO - 'TMOUT': '86400', 14:04:44 INFO - 'USER': 'cltbld', 14:04:44 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:44 INFO - '_': '/tools/buildbot/bin/python'} 14:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:04:46 INFO - Installing collected packages: mozsystemmonitor 14:04:46 INFO - Running setup.py install for mozsystemmonitor 14:04:46 INFO - Successfully installed mozsystemmonitor 14:04:46 INFO - Cleaning up... 14:04:47 INFO - Return code: 0 14:04:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:47 INFO - Using env: {'DISPLAY': ':0', 14:04:47 INFO - 'HOME': '/home/cltbld', 14:04:47 INFO - 'LANG': 'en_US.UTF-8', 14:04:47 INFO - 'LANGUAGE': 'en_US:en', 14:04:47 INFO - 'LOGNAME': 'cltbld', 14:04:47 INFO - 'MAIL': '/var/mail/cltbld', 14:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:47 INFO - 'MOZ_NO_REMOTE': '1', 14:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:47 INFO - 'NO_EM_RESTART': '1', 14:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:47 INFO - 'PWD': '/builds/slave/test', 14:04:47 INFO - 'SHELL': '/bin/bash', 14:04:47 INFO - 'SHLVL': '1', 14:04:47 INFO - 'TERM': 'linux', 14:04:47 INFO - 'TMOUT': '86400', 14:04:47 INFO - 'USER': 'cltbld', 14:04:47 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:47 INFO - '_': '/tools/buildbot/bin/python'} 14:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:49 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 14:04:49 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 14:04:49 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 14:04:49 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 14:04:49 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 14:04:49 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 14:04:49 INFO - Downloading docopt-0.6.1.tar.gz 14:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:49 INFO - Running setup.py install for blobuploader 14:04:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:49 INFO - Running setup.py install for requests 14:04:50 INFO - Running setup.py install for docopt 14:04:50 INFO - Successfully installed blobuploader requests docopt 14:04:50 INFO - Cleaning up... 14:04:50 INFO - Return code: 0 14:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 14:04:50 INFO - Using env: {'DISPLAY': ':0', 14:04:50 INFO - 'HOME': '/home/cltbld', 14:04:50 INFO - 'LANG': 'en_US.UTF-8', 14:04:50 INFO - 'LANGUAGE': 'en_US:en', 14:04:50 INFO - 'LOGNAME': 'cltbld', 14:04:50 INFO - 'MAIL': '/var/mail/cltbld', 14:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:50 INFO - 'MOZ_NO_REMOTE': '1', 14:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:50 INFO - 'NO_EM_RESTART': '1', 14:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:50 INFO - 'PWD': '/builds/slave/test', 14:04:50 INFO - 'SHELL': '/bin/bash', 14:04:50 INFO - 'SHLVL': '1', 14:04:50 INFO - 'TERM': 'linux', 14:04:50 INFO - 'TMOUT': '86400', 14:04:50 INFO - 'USER': 'cltbld', 14:04:50 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:50 INFO - '_': '/tools/buildbot/bin/python'} 14:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:50 INFO - Running setup.py (path:/tmp/pip-C9ZnBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:50 INFO - Running setup.py (path:/tmp/pip-MxwNzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:50 INFO - Running setup.py (path:/tmp/pip-4W_DyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:50 INFO - Running setup.py (path:/tmp/pip-bl8dj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:50 INFO - Running setup.py (path:/tmp/pip-sDt59U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:50 INFO - Running setup.py (path:/tmp/pip-MRz3Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:50 INFO - Running setup.py (path:/tmp/pip-oJn8m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:50 INFO - Running setup.py (path:/tmp/pip-mp8Fmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:51 INFO - Running setup.py (path:/tmp/pip-UwVAQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:51 INFO - Running setup.py (path:/tmp/pip-2KKmgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:51 INFO - Running setup.py (path:/tmp/pip-UQhpzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:51 INFO - Running setup.py (path:/tmp/pip-CMoa09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:51 INFO - Running setup.py (path:/tmp/pip-mWdznN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:51 INFO - Running setup.py (path:/tmp/pip-QzE1E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:51 INFO - Running setup.py (path:/tmp/pip-Ofztbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:51 INFO - Running setup.py (path:/tmp/pip-LTxhrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:51 INFO - Running setup.py (path:/tmp/pip-NmR2Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:51 INFO - Running setup.py install for manifestparser 14:04:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:51 INFO - Running setup.py install for mozcrash 14:04:51 INFO - Running setup.py install for mozdebug 14:04:51 INFO - Running setup.py install for mozdevice 14:04:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozfile 14:04:52 INFO - Running setup.py install for mozhttpd 14:04:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozinfo 14:04:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozInstall 14:04:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozleak 14:04:52 INFO - Running setup.py install for mozlog 14:04:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for moznetwork 14:04:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozprocess 14:04:52 INFO - Running setup.py install for mozprofile 14:04:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:52 INFO - Running setup.py install for mozrunner 14:04:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:53 INFO - Running setup.py install for mozscreenshot 14:04:53 INFO - Running setup.py install for moztest 14:04:53 INFO - Running setup.py install for mozversion 14:04:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:04:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:53 INFO - Cleaning up... 14:04:53 INFO - Return code: 0 14:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:53 INFO - Using env: {'DISPLAY': ':0', 14:04:53 INFO - 'HOME': '/home/cltbld', 14:04:53 INFO - 'LANG': 'en_US.UTF-8', 14:04:53 INFO - 'LANGUAGE': 'en_US:en', 14:04:53 INFO - 'LOGNAME': 'cltbld', 14:04:53 INFO - 'MAIL': '/var/mail/cltbld', 14:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:53 INFO - 'MOZ_NO_REMOTE': '1', 14:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:53 INFO - 'NO_EM_RESTART': '1', 14:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:53 INFO - 'PWD': '/builds/slave/test', 14:04:53 INFO - 'SHELL': '/bin/bash', 14:04:53 INFO - 'SHLVL': '1', 14:04:53 INFO - 'TERM': 'linux', 14:04:53 INFO - 'TMOUT': '86400', 14:04:53 INFO - 'USER': 'cltbld', 14:04:53 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:53 INFO - '_': '/tools/buildbot/bin/python'} 14:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:53 INFO - Running setup.py (path:/tmp/pip-_JsnUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:53 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)) 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:53 INFO - Running setup.py (path:/tmp/pip-GK8NiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:53 INFO - Running setup.py (path:/tmp/pip-oaCi1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:53 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)) 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:53 INFO - Running setup.py (path:/tmp/pip-rQoehl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:53 INFO - Running setup.py (path:/tmp/pip-PUec4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:53 INFO - Running setup.py (path:/tmp/pip-Gy4UKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:54 INFO - Running setup.py (path:/tmp/pip-6XGmjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:54 INFO - Running setup.py (path:/tmp/pip-a7tMc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:54 INFO - Running setup.py (path:/tmp/pip-26uc2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:54 INFO - Running setup.py (path:/tmp/pip-gtV5vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:54 INFO - Running setup.py (path:/tmp/pip-Pu_fZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:54 INFO - Running setup.py (path:/tmp/pip-LGvNFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:54 INFO - Running setup.py (path:/tmp/pip-Oy9SMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:54 INFO - Running setup.py (path:/tmp/pip-1IIVQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:54 INFO - Running setup.py (path:/tmp/pip-kc4Et6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:54 INFO - Running setup.py (path:/tmp/pip-RjnSsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:54 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)) 14:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:54 INFO - Running setup.py (path:/tmp/pip-o58gFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:54 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)) 14:04:54 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:54 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:54 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)) 14:04:54 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:54 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:54 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 14:04:54 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 14:04:54 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 14:04:54 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 14:04:54 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 14:04:54 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 14:04:56 INFO - Downloading blessings-1.5.1.tar.gz 14:04:56 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:56 INFO - Installing collected packages: blessings 14:04:56 INFO - Running setup.py install for blessings 14:04:56 INFO - Successfully installed blessings 14:04:56 INFO - Cleaning up... 14:04:56 INFO - Return code: 0 14:04:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:04:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:57 INFO - Reading from file tmpfile_stdout 14:04:57 INFO - Current package versions: 14:04:57 INFO - argparse == 1.2.1 14:04:57 INFO - blessings == 1.5.1 14:04:57 INFO - blobuploader == 1.2.4 14:04:57 INFO - docopt == 0.6.1 14:04:57 INFO - manifestparser == 1.1 14:04:57 INFO - mozInstall == 1.12 14:04:57 INFO - mozcrash == 0.16 14:04:57 INFO - mozdebug == 0.1 14:04:57 INFO - mozdevice == 0.47 14:04:57 INFO - mozfile == 1.2 14:04:57 INFO - mozhttpd == 0.7 14:04:57 INFO - mozinfo == 0.9 14:04:57 INFO - mozleak == 0.1 14:04:57 INFO - mozlog == 3.1 14:04:57 INFO - moznetwork == 0.27 14:04:57 INFO - mozprocess == 0.22 14:04:57 INFO - mozprofile == 0.27 14:04:57 INFO - mozrunner == 6.11 14:04:57 INFO - mozscreenshot == 0.1 14:04:57 INFO - mozsystemmonitor == 0.0 14:04:57 INFO - moztest == 0.7 14:04:57 INFO - mozversion == 1.4 14:04:57 INFO - psutil == 3.1.1 14:04:57 INFO - requests == 1.2.3 14:04:57 INFO - wsgiref == 0.1.2 14:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:57 INFO - Using env: {'DISPLAY': ':0', 14:04:57 INFO - 'HOME': '/home/cltbld', 14:04:57 INFO - 'LANG': 'en_US.UTF-8', 14:04:57 INFO - 'LANGUAGE': 'en_US:en', 14:04:57 INFO - 'LOGNAME': 'cltbld', 14:04:57 INFO - 'MAIL': '/var/mail/cltbld', 14:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:57 INFO - 'MOZ_NO_REMOTE': '1', 14:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:57 INFO - 'NO_EM_RESTART': '1', 14:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:57 INFO - 'PWD': '/builds/slave/test', 14:04:57 INFO - 'SHELL': '/bin/bash', 14:04:57 INFO - 'SHLVL': '1', 14:04:57 INFO - 'TERM': 'linux', 14:04:57 INFO - 'TMOUT': '86400', 14:04:57 INFO - 'USER': 'cltbld', 14:04:57 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:57 INFO - '_': '/tools/buildbot/bin/python'} 14:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:57 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 1)) 14:04:57 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 2)) 14:04:57 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 3)) 14:04:57 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 4)) 14:04:57 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 5)) 14:04:57 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 6)) 14:04:57 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 7)) 14:04:57 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 8)) 14:04:57 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:57 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 3)) 14:04:57 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:57 INFO - Cleaning up... 14:04:57 INFO - Return code: 0 14:04:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:57 INFO - Using env: {'DISPLAY': ':0', 14:04:57 INFO - 'HOME': '/home/cltbld', 14:04:57 INFO - 'LANG': 'en_US.UTF-8', 14:04:57 INFO - 'LANGUAGE': 'en_US:en', 14:04:57 INFO - 'LOGNAME': 'cltbld', 14:04:57 INFO - 'MAIL': '/var/mail/cltbld', 14:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:57 INFO - 'MOZ_NO_REMOTE': '1', 14:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:57 INFO - 'NO_EM_RESTART': '1', 14:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:57 INFO - 'PWD': '/builds/slave/test', 14:04:57 INFO - 'SHELL': '/bin/bash', 14:04:57 INFO - 'SHLVL': '1', 14:04:57 INFO - 'TERM': 'linux', 14:04:57 INFO - 'TMOUT': '86400', 14:04:57 INFO - 'USER': 'cltbld', 14:04:57 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:57 INFO - '_': '/tools/buildbot/bin/python'} 14:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:57 INFO - Downloading/unpacking jsonschema 14:04:57 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 14:04:57 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 14:04:57 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 14:04:57 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 14:04:57 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 14:04:57 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 14:04:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:04:59 INFO - Downloading/unpacking functools32 (from jsonschema) 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:59 INFO - warning: no files found matching '*.txt' 14:04:59 INFO - no previously-included directories found matching 'build' 14:04:59 INFO - no previously-included directories found matching 'dist' 14:04:59 INFO - no previously-included directories found matching '.git*' 14:04:59 INFO - Installing collected packages: jsonschema, functools32 14:04:59 INFO - Running setup.py install for functools32 14:04:59 INFO - warning: no files found matching '*.txt' 14:04:59 INFO - no previously-included directories found matching 'build' 14:04:59 INFO - no previously-included directories found matching 'dist' 14:04:59 INFO - no previously-included directories found matching '.git*' 14:04:59 INFO - Successfully installed jsonschema functools32 14:04:59 INFO - Cleaning up... 14:04:59 INFO - Return code: 0 14:04:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbc4ca47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', '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 14:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 14:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 14:04:59 INFO - Using env: {'DISPLAY': ':0', 14:04:59 INFO - 'HOME': '/home/cltbld', 14:04:59 INFO - 'LANG': 'en_US.UTF-8', 14:04:59 INFO - 'LANGUAGE': 'en_US:en', 14:04:59 INFO - 'LOGNAME': 'cltbld', 14:04:59 INFO - 'MAIL': '/var/mail/cltbld', 14:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:59 INFO - 'MOZ_NO_REMOTE': '1', 14:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:59 INFO - 'NO_EM_RESTART': '1', 14:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:59 INFO - 'PWD': '/builds/slave/test', 14:04:59 INFO - 'SHELL': '/bin/bash', 14:04:59 INFO - 'SHLVL': '1', 14:04:59 INFO - 'TERM': 'linux', 14:04:59 INFO - 'TMOUT': '86400', 14:04:59 INFO - 'USER': 'cltbld', 14:04:59 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:59 INFO - '_': '/tools/buildbot/bin/python'} 14:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:59 INFO - Downloading/unpacking flake8 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:05:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:05:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:05:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:05:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:02 INFO - no previously-included directories found matching 'docs/_build' 14:05:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:05:02 INFO - Running setup.py install for pep8 14:05:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:02 INFO - no previously-included directories found matching 'docs/_build' 14:05:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:05:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:05:02 INFO - Cleaning up... 14:05:02 INFO - Return code: 0 14:05:02 INFO - Running post-action listener: _resource_record_post_action 14:05:02 INFO - Running post-action listener: _start_resource_monitoring 14:05:02 INFO - Starting resource monitoring. 14:05:02 INFO - ##### 14:05:02 INFO - ##### Running install step. 14:05:02 INFO - ##### 14:05:02 INFO - Running pre-action listener: _resource_record_pre_action 14:05:02 INFO - Running main action method: install 14:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:02 INFO - Reading from file tmpfile_stdout 14:05:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:02 INFO - Reading from file tmpfile_stdout 14:05:02 INFO - Output received: 14:05:02 INFO - Usage: mozinstall [options] installer 14:05:02 INFO - Options: 14:05:02 INFO - -h, --help show this help message and exit 14:05:02 INFO - -d DEST, --destination=DEST 14:05:02 INFO - Directory to install application into. [default: 14:05:02 INFO - "/builds/slave/test"] 14:05:02 INFO - --app=APP Application being installed. [default: firefox] 14:05:02 INFO - mkdir: /builds/slave/test/build/application 14:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:05:17 INFO - Reading from file tmpfile_stdout 14:05:17 INFO - Output received: 14:05:17 INFO - /builds/slave/test/build/application/firefox/firefox 14:05:17 INFO - Running post-action listener: _resource_record_post_action 14:05:17 INFO - ##### 14:05:17 INFO - ##### Running run-tests step. 14:05:17 INFO - ##### 14:05:17 INFO - Running pre-action listener: _resource_record_pre_action 14:05:17 INFO - Running main action method: run_tests 14:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:05:17 INFO - Python 2.7.3 14:05:17 INFO - Return code: 0 14:05:17 INFO - grabbing minidump binary from tooltool 14:05: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')]} 14:05:17 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 0x17610b0>, '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 0x1761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1762440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:05:17 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 14:05:17 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 14:05:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:17 INFO - Return code: 0 14:05:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:05:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:05:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:05:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:05:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:05:18 INFO - Return code: 0 14:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 14:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:05:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test', 14:05:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 14:05:18 INFO - mozversion INFO | application_buildid: 20151206131030 14:05:18 INFO - mozversion INFO | application_changeset: 29e5fb8c86db75eafcc44dc607f7a00312ce0f47 14:05:18 INFO - mozversion INFO | application_display_name: Nightly 14:05:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:18 INFO - mozversion INFO | application_name: Firefox 14:05:18 INFO - mozversion INFO | application_remotingname: firefox 14:05:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 14:05:18 INFO - mozversion INFO | application_vendor: Mozilla 14:05:18 INFO - mozversion INFO | application_version: 45.0a1 14:05:18 INFO - mozversion INFO | platform_buildid: 20151206131030 14:05:18 INFO - mozversion INFO | platform_changeset: 29e5fb8c86db75eafcc44dc607f7a00312ce0f47 14:05:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 14:05:18 INFO - mozversion INFO | platform_version: 45.0a1 14:05:18 INFO - 2015-12-06 14:05:18,426 DEBUG : using testdate: 1449439518 14:05:18 INFO - 2015-12-06 14:05:18,426 DEBUG : actual date: 1449439518 14:05:18 INFO - 2015-12-06 14:05:18,477 INFO : starting webserver on 'localhost:60720' 14:05:18 INFO - 2015-12-06 14:05:18,478 INFO : Starting test suite talos-linux64-ix-048 14:05:18 INFO - 2015-12-06 14:05:18,478 INFO : Starting test dromaeo_css 14:05:18 INFO - 2015-12-06 14:05:18,478 DEBUG : operating with platform_type : linux_ 14:05:18 INFO - 2015-12-06 14:05:18,479 INFO : Initialising browser for dromaeo_css test... 14:05:18 INFO - 2015-12-06 14:05:18,495 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpniISB5/profile http://localhost:60720/getInfo.html 14:05:22 INFO - 2015-12-06 14:05:22,634 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:05:22 INFO - 2015-12-06 14:05:22,634 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:05:22 INFO - 2015-12-06 14:05:22,634 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:05:22 INFO - 2015-12-06 14:05:22,634 DEBUG : BROWSER_OUTPUT: __metrics 14:05:22 INFO - 2015-12-06 14:05:22,722 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:22 INFO - 2015-12-06 14:05:22,803 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:23 INFO - 2015-12-06 14:05:23,916 INFO : Browser initialized. 14:05:23 INFO - 2015-12-06 14:05:23,916 INFO : Running cycle 1/1 for dromaeo_css test... 14:05:23 INFO - 2015-12-06 14:05:23,916 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpniISB5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:35 INFO - 2015-12-06 14:05:35,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 142770176 14:05:35 INFO - 2015-12-06 14:05:35,851 DEBUG : BROWSER_OUTPUT: 14:06:26 INFO - 2015-12-06 14:06:26,645 DEBUG : BROWSER_OUTPUT: 1449439586644 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] 14:08:39 INFO - 2015-12-06 14:08:39,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60720/tests/dromaeo/cssquery-ext.html) 14:08:40 INFO - 2015-12-06 14:08:40,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 252915712 14:08:40 INFO - 2015-12-06 14:08:40,893 DEBUG : BROWSER_OUTPUT: 14:11:43 INFO - 2015-12-06 14:11:43,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-ext.html (next: http://localhost:60720/tests/dromaeo/cssquery-jquery.html) 14:11:44 INFO - 2015-12-06 14:11:44,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 223399936 14:11:44 INFO - 2015-12-06 14:11:44,011 DEBUG : BROWSER_OUTPUT: 14:14:46 INFO - 2015-12-06 14:14:46,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60720/tests/dromaeo/cssquery-mootools.html) 14:14:46 INFO - 2015-12-06 14:14:46,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 218312704 14:14:46 INFO - 2015-12-06 14:14:46,690 DEBUG : BROWSER_OUTPUT: 14:17:48 INFO - 2015-12-06 14:17:48,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60720/tests/dromaeo/cssquery-prototype.html) 14:17:49 INFO - 2015-12-06 14:17:49,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 204939264 14:17:49 INFO - 2015-12-06 14:17:49,199 DEBUG : BROWSER_OUTPUT: 14:20:51 INFO - 2015-12-06 14:20:51,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60720/tests/dromaeo/cssquery-yui.html) 14:20:52 INFO - 2015-12-06 14:20:52,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 209707008 14:20:52 INFO - 2015-12-06 14:20:52,495 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/dromaeo/cssquery-yui.html (next: http://localhost:60720/tests/dromaeo/cssquery-dojo.html) 14:23:55 INFO - 2015-12-06 14:23:55,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 252989440 14:23:55 INFO - 2015-12-06 14:23:55,255 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:23:55 INFO - 2015-12-06 14:23:55,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:23:55 INFO - 2015-12-06 14:23:55,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:23:55 INFO - 2015-12-06 14:23:55,256 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:23:55 INFO - 2015-12-06 14:23:55,257 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.032807861091;2703.040420650669;2713.2402927180397;2717.605947137665;2733.275681944285;4552.203364411232;4650.302454631803;4688.976555117229;4712.740799256039;4720.952790472094;4562.429696287964;4603.964108075681;4686.601638860701;4688.2733176357715;4707.811687532503;4270.210011147948;4273.87178384649;4349.2606256936315;4372.759498227596;4392.12157568486;4335.848245311415;4371.431713877191;4396.186705459484;4397.626201772837;4446.688731788776;4132.276851550967;4221.620054195107;4233.894152646178;4247.129338485603;4357.172137293904;4324.718893271927;4329.242382583036;4331.956680433187;4340.956590434087;4366.454193225847;4300.763458009808;4315.266404711207;4324.610785029363;4341.826326946918;4355.433793606842;4411.492678341968;4536.160810250114;4540.8864778380475;4616.930746038812;4731.716097034189;4973.353464049686;5057.140286151363;5058.949410505885;5065.848024559269;5102;5078.289039534431;5080.517350851663;5085;5092.643514953955;5121.564667003309;4557.498675145731;4676.041411510632;4691.507391723888;4703.529647035338;4824.179889418737;5237.3453318335205;5278.97360513195;5286.36563612369;5289.047971365191;5290.100682883919;5072.847814565569;5077.543021128116;5077.543021128116;5080.796768129308;5128.076946149728;4787.2101103318255;4890.853274401774;4891.095147397672;4973.079980203674;5073.061483625541;4995.575376093073;5035.62232832539;5036.169032109734;5037.672551284155;5095.133827249377;5010.799568017239;5014.52362025607;5015.824446144367;5017.523335283142;5021;3677.2645470905927;3707.8146092695797;3718.163413232001;3829.0235989822418;3917.9216415671526;3487.5814902211896;3491.4937334086417;3515.7538972271695;3523.418635925095;3529;4367.344898265285;4372.540883207281;4372.650187984954;4374.562543745664;4411.84558540456;4775.904481910342;4879.878003049952;4881.487443818419;4990.476000020019;5029.270755740397;4345.782710864444;4347.978260108743;4349.608535231844;4368.563143685606;4373.890652733643;4445.444319460067;4457.24226881431;4457.509673935864;4460.687751857339;4496.437945256843;4602.539746025371;4711.552402521892;4712.59942904857;4732.597729193058;4849.102915960488;5093.388793344822;5102;5109.3613298337705;5114.15616423286;5131.409887862944;4862.07620552094;4865.489123641966;4868.050730107595;4869.4400143982475;4901.90196196067;4739.739314337745;4850.587700045536;4854.757262136808;4857.295692124551;5075.3402057732255;5074.797008119634;5079.568236699922;5081.491850815037;5081.92377114351;5125.8974820502635;4922.4339200992345;4925.1873440881855;4925.852224433273;4926.753662316942;4963.602911766978;4689.882752931204;4714.269288260325;4775.474697783172;4783.282507623884;4966.652334336562;4772.403449568804;4781.856544303677;4799.736014519235;4834.8791280216865;4871.464138944784;4918.95081049185;4919.508049195052;4919.557239848287;4923.753812309298;4970.030843985533;4570.451545814523;4600.355950167046;4651.279051746985;4655.743934083658;4854.75726213695 14:23:55 INFO - 2015-12-06 14:23:55,258 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.1431509892711;575.0999685492204;577.4225774225777;582.7086456771614;584.777784441912;29347.413051738953;30065;38762.224755504874;39131.21737565247;39224.60775392245;42236.78881605595;42775.35836962448;42809.14381712364;42847.78576107123;42878.35682464758;7147.178074521445;7278.563286202845;7919.287264146211;8097.716579919704;8102.918970810276;9847.310688251826;10070.194384449263;10071.395716257011;10073.496325183749;10074.89925100747;9690.127888490035;9835.70492885211;9836.70489885301;9844;9847.803043939117;7373.446991475634;7548.094228692592;9741.269404794633;10439.530221140067;10698.090662293715;9888.653897113567;9984.700458986243;9987.300888937778;9995;9996.150327222194;38895;39209.411858821855;39304.60695393038;39331;39437.80281098576;2676.585129304961;2857.6856545779947;3151.448496513101;3220.4203243416177;3353.8658453661824;28105.85947070272;28321.15036548907;28361.14916552507;28448.146555603365;28552.857235713687;3398.5921689397182;3442.535257740223;3451.5340429042008;3496.615372309044;3536.0806190390686;224196;224609;224833;225104.48955104523;225167;56420.30739077834;56729;56849;56886.43113568894;56905.430945690016;49045.5095449041;50602.74698626557;60071.69964150151;60190.69904650536;60250;12730.299833509062;12743.171693839871;12816.743665126645;12819.679508012188;12865.549705760253;9580.904190958141;9617.71146865595;9628.085331893459;9629.855552166724;9633.08485693858;18855;19329.710054349194;19335.51661208481;19353.612927741367;19368;7126.750563730245;7248.746293879794;7270;7373.373263272575;7384.815379615553;876.5398165962921;909.6497848328441;924.4822899176482;978.496074521622;989.0159291504999;26583.601245981325;26636.80134393957;27488.45023099527;28967.275818104295;30296.5455518163;946.6402766948515;956.8899576548786;1027.3117011602094;1051.30613794895;1095.1403148528368;13514.391852366667;13607.909553713691;13872.583822485341;13876.791848122286;13963.162210267417;260448;265617;266043;266182;266287;46567.534324657;46866.29700554494;46902.296465553045;46905;46909.53090469052;1205.1744554979866;1207.106741011645;1221.975560488803;1228.2569045727384;1231.5073970411906;25356.619650705623;25609;25848.353791155372;26298.21105366842;26395;41563.37654935239;41763;41799.37300940549;41910.58089419189;41941;236519;241789;248178;250447;335611;28139.43721125607;28388.574171387034;28450.14649560434;28548.714512854607;28699.569506457003;38786.93205844483;38828.80585597054;39884.401733973435;39898.40152397774;40012.199756004135;33568.32158392119;33597;34177.82911085528;34194;34658.306833862676;32760.50859237161;34227;34570;34782;34821.30357392787;30609;31240.21899452532;31245.37509249757;31423.371532568763;31572.526412104296;28261.43477130487;30162.547561786152;30572.929947451732;30627.2343191422;30792.381142828755;24489.51020979606;25555.74444255608;25575.872120639277;25585.48829023372;25849.612255815802 14:23:55 INFO - 2015-12-06 14:23:55,262 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.9237404971048;328.50559907339454;329.73456367624055;330.93050459403526;333.6130089096648;12374.876251237485;12770.872291277085;14957.5512734618;15243.542693719191;15377.923110384447;11688.941555292211;13299.734005319888;13402.865971340283;13459.932700336509;13539.661508462294;3666.4683620874957;4763.833265835697;4775.379200703912;4900.215965445529;4919;3582.283543291339;3669.3945498992634;4848.490908454614;4907.2639104134305;5522.199281104237;5499.340079190502;5534.584906132056;5576.191452239423;5623.0721930881355;5629.7185140742795;4847.2002119650215;5000.974995125001;5008.1486147355035;5008.449070602231;5523.25436066132;4675.158471475133;4812.109759694467;4828.903421931577;4831.4202295724735;4974.77613507393;11318.377489238088;11449.771004579945;11496.137789665809;11502.539898404053;14564.490242841555;1742.0418769676628;1763.938262160831;1766.2316892151828;1776.6180271241744;1830.6247219320007;8483.533405662685;8486.575671216477;8738.082501337396;8975.41659792118;9067.365284430092;1579.2261791721974;1630.9102999335032;1689.06257027351;1743.0500377294404;1749;55761.44238557603;56413.717931410494;57564.712176439265;58485.41514584842;59040.11439828406;9355.719328420022;9693.806123877483;9725.0761177688;9806.75483112928;9817.723695919485;12427.813582796265;12437.191582547106;12448.75102497963;12453.564125255572;12457.501699931901;6696.631685257357;6736.955771855371;6845.452363810883;6890.483213758988;6923.826904327432;6422.775202867971;6462.159919210472;6549.476041916635;6626;6631.502637302222;4068.8372465101065;4238.21593005295;4245.80893859777;4261.552536983634;4268.551802060801;1585.3658536585458;1646.168684814185;1648.4807285705203;1691.1797778077623;1725.1288099509668;358.1279584212451;358.76680157897573;746.9365103966115;817.1787353709602;823.555280148713;9484.099010593982;9988.750281242881;10288.382697038202;10293.43386113771;10336.5348559315;347.5481873564407;366.417396339821;389.1943676589433;392.61915941536665;397.4118304908751;5235.921461178085;5326.733663316819;5401.02781499326;5443.727813609304;5484.2596249506605;450389;472408;473959;481050;485672;71845;72195.63902180456;73483.63258183675;74218.6289068562;74581;419.35210100394966;424.85554911330297;425.0351701637266;425.07334011854454;425.5446672060927;9396.624135034523;9410.482423466776;9477.431354118775;9511;9538.427694338361;29816.850915745283;30989.535156973114;31267.51697366639;31372.843135784176;31614.36771264608;41610.58389416067;42738.57261427346;42977.78511107424;43645.56354436415;44139;8701.956490217508;8793.252573531321;8864.335174861782;8944.88188976378;8952.910470895207;10417.479126043516;15177.848221517643;15388.84611153919;15414.84585154134;15467.922660386626;13391.129576577492;13779.517716880262;13808.585742427744;13825.308734563432;14133.575992720234;12677.239365638092;13014.739705205653;13196.934015329862;13253.602391928258;13523.323833808467;10498.160147188359;12285.508579657071;13342;13940.233287168898;14184.36170372315;8891.155340242667;8930.19628233462;9135.543222838964;9150.359474836698;9177.082291771036;13945.651358716113;13993.230372329212;14108.365123569669;14129;14359.856401435853 14:23:55 INFO - 2015-12-06 14:23:55,263 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1454.5418193269113;1709.358990378608;1749.5888466210438;1778.4131236691892;1783.8662100342478;5984.28188617366;7196.208417074117;7400;7402.629868506567;7406.703731850733;7200.891986620205;7354.742584009561;7358.595277259748;7358.926410735891;7364.815879603013;2021.161218094489;2071.2439959414783;2071.968920466194;2073.39871437283;2073.637113505138;2067.1111422088497;2081.032319971213;2092.257248676721;2120.4592828828704;2121.087932189158;2020.535276886317;2043.3563427520357;2053.3326668832688;2054.4452997690614;2055.3320170944503;2051.7845626209255;2072.3782865140397;2073.906674199665;2074.678424844152;2075.1595603780493;2016.5765189310262;2030.4720772599082;2058.3310424112224;2060.9896950515304;2061.7319748432756;7257.092863392076;7344.742933997338;7349.63251837406;7354.154272258652;7357;4062.1672557125717;4127.587241275878;4128.236276288866;4128.380742888561;4131.9173616527805;2626.2909014566153;2644.8809803558693;2672.8930842766267;2687.4490729400427;2704.8512331821744;858.5750053723447;869.6043300298412;879;884.0275696733606;905.7011186308503;9966.9501652492;9981.60073597048;9987.250956178243;9987.950060249725;10003.299769016172;3854.5567259764925;3875.8837234883;3915.158240978203;3935.763854168759;3935.7835319057726;8624.95687521571;8627.956860215785;8638.438501497383;8643.827123457495;8656.913430865736;4182.477190351206;4198.181354635878;4205.516365617932;4205.600467955601;4206.053637931441;3082.969170308268;3153.132888455693;3627.2564124354444;3763.1156678180605;3779.829907654162;3367.5285460035616;3416.0947348952545;3444.4144495435835;3452.602950660656;3464.047386968604;1051.5163025008428;1057.0539367266254;1057.8836328003913;1080.6055789636882;1092.2299778656188;1144.1704764046167;1161.7618388230392;1166.8658104317942;1207.7584483103415;1243.1670780577035;6767.323267673291;6917.861642767117;6932.618705971119;6951;6965.930340696629;397.1600065860684;400.01995111975776;401.18158955730564;401.84930651005874;402.16751324758053;5343.145096784574;5413.323334583177;5424.701641409761;5432.809851655173;5435.83692489226;8726.214640682369;8740.650373985096;8795.384323097449;8912.910870891337;8956.641734330684;8773.517456539825;8818.074102219174;8874.778130546789;8887.955560222286;8905.910940890637;6852.931470685229;6859.211190713132;6970.163580370388;6986.301369862973;7025.192102908231;6621.635810030494;6707.128073350434;6713.160854893138;6715.597064176165;6724.4620430364475;7799.936626133762;7900.644470998704;7921.603919804102;7990.560519171501;8024.719134830253;8069.556174410463;8129.67481300765;8138.104808470945;8231.053428855757;8282.544460054754;5526.143447765603;5701.059325211294;6212.782552610637;6403.3276505966205;6437.67811609427;6920.757773477904;6928.203256625553;6928.445724342141;6948.166220053626;6969.860602788017;6357.268914074941;6522.445592124533;6566.967165164144;6576.441002514648;6669.166354205724;6355.364463553793;6485.935140648533;6486.318936511599;6498.0252962056065;6531.477481801349;6374.681265936777;6391.201099862517;6399.200099987502;6414.390632889868;6424.775132870327;5565.3599836019375;5681.204631351531;5695.772169113189;5823.242978412779;5872.119182122716;5980.730867111078;6024.789132380346;6040.305364883095;6040.335563088145;6059.212302400836 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.54288609465243;279.2780661988759;279.7356498109287;282.87270728172314;288.1801275371567;5338.306020217376;5371.731413429327;5431.103867861803;5431.701256430894;5450.3459584849825;5221.485769126958;5331.440198779131;5344.038073146832;5348.812791552296;5370.167624018273;4130.194612050651;4139.855105071308;4139.9793001035105;4148.460700108982;4151.149014452045;3907.7069219808486;4000.639942405183;4008.5790991945864;4073.5926407359175;4092.0997380576227;3996.3605823068315;4034.5360283567325;4041.333180025292;4043.8180281887385;4071.063655359269;3871.8838434846716;4049.817758200888;4050.108976025255;4056.7565946043333;4069.7965101744794;3444.328355970587;3464.6881780639865;3528.770629909048;3539.876104336336;3549.804760738158;5163.3545806774155;5168.043911876277;5175.611829112831;5179.974100129513;5188.351456067991;4672.065586882603;4680.134175177603;4680.297955306697;4683.531646835323;4685.4143232095985;5458.181272809111;5600.383957764642;5601.383847776741;5606.915896261559;5608.691521966291;3839.2897313996723;3843.538775346948;3844.788536630484;3848.3457812171996;3854.670138802109;5849.824505264849;5927.673977931255;5934.465898069151;5940.257467816523;5940.7920722774925;3963.6721698231418;3964.940525892114;3967.6032396760093;3969.4442778011103;3969.503812023497;4019.1559772448113;4023.839046438168;4026.4564283821896;4034.334334834778;4036.0313524753847;4486.439195100613;4638.512956139624;4660.13787449323;4692.460367057832;4692.507286734912;5638.520725738276;5643.5203007743985;5648.15277708347;5655;5661.377248502661;1398.5664444022182;1419.1130543410368;1419.815423994874;1419.872211500949;1420.2330741399735;919.048784508031;919.3932004876749;931.8276118918022;947.3889341374775;949.0888746803008;4955.529224723646;4962;4962.553370196628;4966.230234313687;4966.279889416014;5855.297364316224;5864.354920958691;5866;5867.090600956859;5870.031444811559;4947.529984651453;4956.479569645136;4958.801647934042;4959.082569724613;4959.776810043557;3068.5397190421168;3121.9687803122133;3155.4477966355794;3159.178613560445;3161.9051428457183;5404.486573775485;5462.371827239839;5535.086710692691;5615.803446879339;5625.915611265835;6054.909176362358;6057.273127224761;6059.333473317932;6063.090536419572;6069.2716873975405;5595.356533998561;5595.860103497445;5600.803971860965;5603.635763675348;5608.2148499209325;5685.943140568541;5835;5845.561582881216;5871.647701137946;5878.588498805214;5750.166225897305;5750.568707346882;5762.135679648086;5762.6830524319885;5766.481016708516;5593.972030139823;5597.860053498533;5598.384177740364;5601.971990140186;5603.299587551556;3839.6544311012144;3872.5159355080614;3872.6514613684903;3874.748141370802;3875.748076375027;5719.456651618089;5872.530197584098;5883.117532370179;5884.47039766423;5889.381614930542;5660.575456840671;5663.235463212578;5666.405027472056;5671.773129074791;5677.7161141941915;5662.886742265214;5664.745086471036;5668.064769313017;5678.545716342765;5678.801241956512;5377.354717433933;5523.944760552504;5544.750486228048;5551.195076713773;5555.583331250254;5687.317521897398;5697.971510142423;5698.743556539883;5699.772009119589;5707.68607726579;5454;5533.750981205775;5541.33503979525;5543.223948647112;5547.667139971614 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.1168307140683;750.3734381791204;780.6096951524238;791.3708601661676;806.854766142095;11409;12964.546240881571;13243.139195952257;13257.939364850812;13262.668433289173;13820.378082986264;13908.235047072432;13926.51257205998;13942.372593233304;13947.232902190375;638.0716058135425;644.4940721533598;793.8015496125954;800.0559339978822;808.1796976069265;813.6135335715547;814.6374863185855;819.0212695828487;821.1788211788212;821.4208982667205;835.4903508859591;845.2266176448542;845.3533047218851;846.3102571404286;846.4413487098516;666.4868051600265;673.6126727131895;835.9038710548303;845.8223773007676;848.9405741598091;623.7941479311861;626.2234828812285;626.3986572890032;626.4111734969115;626.9341719119473;11738.47176877034;11747.412629368582;11793.410329483491;11922.463489142923;11927.463264153133;10907;11027.72430689231;11095.667129986114;11104.111671066295;11417.257878237888;9387.718368448957;9456.621735130586;9461.24310055194;9613.375130616558;9686.70939871805;3179.093958221919;3228.96771032289;3257.7230935370285;3292.670732926712;3300.8349582520777;42580.14839703219;42601.57398425976;42882.35676464855;42917;42942.570574294485;8753.212210901049;8905.376623636414;9029.187373136449;9091.454512729126;9113.407628504126;16430.75353869693;16447.177641118134;16453.177341132894;16483.505494835175;16488.0931548766;6224.346443623354;6278.30938596754;6408.935910640927;6456.289808121103;6469.385408386196;3509.4560343146854;3540.7344449166417;3601.63088980595;3663.7618554793853;3719.5722491913234;2717.3885875677815;2739.8630068496495;2746.9038583649476;2749.986250068737;2751.834889906612;476.4906463893469;477.60597507056815;483.41506776800463;483.50440798182143;485.67702477851833;596.5138412194048;598.3209057719432;602.8914795336882;610.8472881779555;616.8612062286039;7884.921150788534;8325;8709.782255443537;8714.21572058505;8868.290536757044;451.4965813118349;466.6803239780761;469.26325668699815;471.549670065087;626.6083697688945;3547.9645203547634;3548.379033669149;3696.094456858087;3734.3651579231596;3754.4931434256573;49803.25295120576;50506.74746626243;50561.49438505568;50901;50923.49076509262;43907.12185756331;44216.55783442189;44431;44450;44617.55382446199;40336.39495407571;41196;41274.79362603168;41573.376399354034;42451.93870153333;6920.861582768417;7325.194228634952;7353.196040662825;7411.4070874328845;7439.479236453396;30466;30495.542566861957;30754.538681920236;30808.229794255323;30943.381132377675;37232.627673724;37253.441198382585;37335.25329493449;40913.59086409098;41204;9605.47169905634;10004.899951000396;10065.748356290858;10269.948650256702;10288.331258468175;11294.43527823622;11344.20590558653;11613.6515904523;11657.53369865196;11775.352355620524;10450.42522661261;10516.158707303244;10562.260641755003;10599.311044782064;10814.891851081704;10903.618373356894;10908.945455272673;11017.504212310305;11044;11496;10895.400752958663;11098.500567474644;11127.109831213646;11309.886901130883;11589.768204636028;9110.180083792491;9202.953985230299;9377.1091746284;9499;9633.42199468006;8628.741137765877;8867.689630863148;8969.372143950122;9175;9299.302552308469 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,948 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: __startTimestamp1449440635253__endTimestamp 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:23:55 INFO - 2015-12-06 14:23:55,267 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:23:55 INFO - 2015-12-06 14:23:55,268 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,268 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4623.31 Median:4731.72 stddev:517.96 (10.9%) stddev-sans-first:494.99 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: Values: 2614.0 2703.0 2713.2 2717.6 2733.3 4552.2 4650.3 4689.0 4712.7 4721.0 4562.4 4604.0 4686.6 4688.3 4707.8 4270.2 4273.9 4349.3 4372.8 4392.1 4335.8 4371.4 4396.2 4397.6 4446.7 4132.3 4221.6 4233.9 4247.1 4357.2 4324.7 4329.2 4332.0 4341.0 4366.5 4300.8 4315.3 4324.6 4341.8 4355.4 4411.5 4536.2 4540.9 4616.9 4731.7 4973.4 5057.1 5058.9 5065.8 5102.0 5078.3 5080.5 5085.0 5092.6 5121.6 4557.5 4676.0 4691.5 4703.5 4824.2 5237.3 5279.0 5286.4 5289.0 5290.1 5072.8 5077.5 5077.5 5080.8 5128.1 4787.2 4890.9 4891.1 4973.1 5073.1 4995.6 5035.6 5036.2 5037.7 5095.1 5010.8 5014.5 5015.8 5017.5 5021.0 3677.3 3707.8 3718.2 3829.0 3917.9 3487.6 3491.5 3515.8 3523.4 3529.0 4367.3 4372.5 4372.7 4374.6 4411.8 4775.9 4879.9 4881.5 4990.5 5029.3 4345.8 4348.0 4349.6 4368.6 4373.9 4445.4 4457.2 4457.5 4460.7 4496.4 4602.5 4711.6 4712.6 4732.6 4849.1 5093.4 5102.0 5109.4 5114.2 5131.4 4862.1 4865.5 4868.1 4869.4 4901.9 4739.7 4850.6 4854.8 4857.3 5075.3 5074.8 5079.6 5081.5 5081.9 5125.9 4922.4 4925.2 4925.9 4926.8 4963.6 4689.9 4714.3 4775.5 4783.3 4966.7 4772.4 4781.9 4799.7 4834.9 4871.5 4919.0 4919.5 4919.6 4923.8 4970.0 4570.5 4600.4 4651.3 4655.7 4854.8 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41546.97 Median:34185.91 stddev:65719.70 (192.2%) stddev-sans-first:65832.05 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: Values: 573.1 575.1 577.4 582.7 584.8 29347.4 30065.0 38762.2 39131.2 39224.6 42236.8 42775.4 42809.1 42847.8 42878.4 7147.2 7278.6 7919.3 8097.7 8102.9 9847.3 10070.2 10071.4 10073.5 10074.9 9690.1 9835.7 9836.7 9844.0 9847.8 7373.4 7548.1 9741.3 10439.5 10698.1 9888.7 9984.7 9987.3 9995.0 9996.2 38895.0 39209.4 39304.6 39331.0 39437.8 2676.6 2857.7 3151.4 3220.4 3353.9 28105.9 28321.2 28361.1 28448.1 28552.9 3398.6 3442.5 3451.5 3496.6 3536.1 224196.0 224609.0 224833.0 225104.5 225167.0 56420.3 56729.0 56849.0 56886.4 56905.4 49045.5 50602.7 60071.7 60190.7 60250.0 12730.3 12743.2 12816.7 12819.7 12865.5 9580.9 9617.7 9628.1 9629.9 9633.1 18855.0 19329.7 19335.5 19353.6 19368.0 7126.8 7248.7 7270.0 7373.4 7384.8 876.5 909.6 924.5 978.5 989.0 26583.6 26636.8 27488.5 28967.3 30296.5 946.6 956.9 1027.3 1051.3 1095.1 13514.4 13607.9 13872.6 13876.8 13963.2 260448.0 265617.0 266043.0 266182.0 266287.0 46567.5 46866.3 46902.3 46905.0 46909.5 1205.2 1207.1 1222.0 1228.3 1231.5 25356.6 25609.0 25848.4 26298.2 26395.0 41563.4 41763.0 41799.4 41910.6 41941.0 236519.0 241789.0 248178.0 250447.0 335611.0 28139.4 28388.6 28450.1 28548.7 28699.6 38786.9 38828.8 39884.4 39898.4 40012.2 33568.3 33597.0 34177.8 34194.0 34658.3 32760.5 34227.0 34570.0 34782.0 34821.3 30609.0 31240.2 31245.4 31423.4 31572.5 28261.4 30162.5 30572.9 30627.2 30792.4 24489.5 25555.7 25575.9 25585.5 25849.6 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25214.50 Median:425.31 stddev:77421.90 (18203.7%) stddev-sans-first:77616.53 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: Values: 327.9 328.5 329.7 330.9 333.6 12374.9 12770.9 14957.6 15243.5 15377.9 11688.9 13299.7 13402.9 13459.9 13539.7 3666.5 4763.8 4775.4 4900.2 4919.0 3582.3 3669.4 4848.5 4907.3 5522.2 5499.3 5534.6 5576.2 5623.1 5629.7 4847.2 5001.0 5008.1 5008.4 5523.3 4675.2 4812.1 4828.9 4831.4 4974.8 11318.4 11449.8 11496.1 11502.5 14564.5 1742.0 1763.9 1766.2 1776.6 1830.6 8483.5 8486.6 8738.1 8975.4 9067.4 1579.2 1630.9 1689.1 1743.1 1749.0 55761.4 56413.7 57564.7 58485.4 59040.1 9355.7 9693.8 9725.1 9806.8 9817.7 12427.8 12437.2 12448.8 12453.6 12457.5 6696.6 6737.0 6845.5 6890.5 6923.8 6422.8 6462.2 6549.5 6626.0 6631.5 4068.8 4238.2 4245.8 4261.6 4268.6 1585.4 1646.2 1648.5 1691.2 1725.1 358.1 358.8 746.9 817.2 823.6 9484.1 9988.8 10288.4 10293.4 10336.5 347.5 366.4 389.2 392.6 397.4 5235.9 5326.7 5401.0 5443.7 5484.3 450389.0 472408.0 473959.0 481050.0 485672.0 71845.0 72195.6 73483.6 74218.6 74581.0 419.4 424.9 425.0 425.1 425.5 9396.6 9410.5 9477.4 9511.0 9538.4 29816.9 30989.5 31267.5 31372.8 31614.4 41610.6 42738.6 42977.8 43645.6 44139.0 8702.0 8793.3 8864.3 8944.9 8952.9 10417.5 15177.8 15388.8 15414.8 15467.9 13391.1 13779.5 13808.6 13825.3 14133.6 12677.2 13014.7 13196.9 13253.6 13523.3 10498.2 12285.5 13342.0 13940.2 14184.4 8891.2 8930.2 9135.5 9150.4 9177.1 13945.7 13993.2 14108.4 14129.0 14359.9 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,269 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5044.33 Median:6032.55 stddev:2696.71 (44.7%) stddev-sans-first:2690.78 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: Values: 1454.5 1709.4 1749.6 1778.4 1783.9 5984.3 7196.2 7400.0 7402.6 7406.7 7200.9 7354.7 7358.6 7358.9 7364.8 2021.2 2071.2 2072.0 2073.4 2073.6 2067.1 2081.0 2092.3 2120.5 2121.1 2020.5 2043.4 2053.3 2054.4 2055.3 2051.8 2072.4 2073.9 2074.7 2075.2 2016.6 2030.5 2058.3 2061.0 2061.7 7257.1 7344.7 7349.6 7354.2 7357.0 4062.2 4127.6 4128.2 4128.4 4131.9 2626.3 2644.9 2672.9 2687.4 2704.9 858.6 869.6 879.0 884.0 905.7 9967.0 9981.6 9987.3 9988.0 10003.3 3854.6 3875.9 3915.2 3935.8 3935.8 8625.0 8628.0 8638.4 8643.8 8656.9 4182.5 4198.2 4205.5 4205.6 4206.1 3083.0 3153.1 3627.3 3763.1 3779.8 3367.5 3416.1 3444.4 3452.6 3464.0 1051.5 1057.1 1057.9 1080.6 1092.2 1144.2 1161.8 1166.9 1207.8 1243.2 6767.3 6917.9 6932.6 6951.0 6965.9 397.2 400.0 401.2 401.8 402.2 5343.1 5413.3 5424.7 5432.8 5435.8 8726.2 8740.7 8795.4 8912.9 8956.6 8773.5 8818.1 8874.8 8888.0 8905.9 6852.9 6859.2 6970.2 6986.3 7025.2 6621.6 6707.1 6713.2 6715.6 6724.5 7799.9 7900.6 7921.6 7990.6 8024.7 8069.6 8129.7 8138.1 8231.1 8282.5 5526.1 5701.1 6212.8 6403.3 6437.7 6920.8 6928.2 6928.4 6948.2 6969.9 6357.3 6522.4 6567.0 6576.4 6669.2 6355.4 6485.9 6486.3 6498.0 6531.5 6374.7 6391.2 6399.2 6414.4 6424.8 5565.4 5681.2 5695.8 5823.2 5872.1 5980.7 6024.8 6040.3 6040.3 6059.2 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4656.34 Median:5370.95 stddev:1401.24 (26.1%) stddev-sans-first:1366.03 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: Values: 274.5 279.3 279.7 282.9 288.2 5338.3 5371.7 5431.1 5431.7 5450.3 5221.5 5331.4 5344.0 5348.8 5370.2 4130.2 4139.9 4140.0 4148.5 4151.1 3907.7 4000.6 4008.6 4073.6 4092.1 3996.4 4034.5 4041.3 4043.8 4071.1 3871.9 4049.8 4050.1 4056.8 4069.8 3444.3 3464.7 3528.8 3539.9 3549.8 5163.4 5168.0 5175.6 5180.0 5188.4 4672.1 4680.1 4680.3 4683.5 4685.4 5458.2 5600.4 5601.4 5606.9 5608.7 3839.3 3843.5 3844.8 3848.3 3854.7 5849.8 5927.7 5934.5 5940.3 5940.8 3963.7 3964.9 3967.6 3969.4 3969.5 4019.2 4023.8 4026.5 4034.3 4036.0 4486.4 4638.5 4660.1 4692.5 4692.5 5638.5 5643.5 5648.2 5655.0 5661.4 1398.6 1419.1 1419.8 1419.9 1420.2 919.0 919.4 931.8 947.4 949.1 4955.5 4962.0 4962.6 4966.2 4966.3 5855.3 5864.4 5866.0 5867.1 5870.0 4947.5 4956.5 4958.8 4959.1 4959.8 3068.5 3122.0 3155.4 3159.2 3161.9 5404.5 5462.4 5535.1 5615.8 5625.9 6054.9 6057.3 6059.3 6063.1 6069.3 5595.4 5595.9 5600.8 5603.6 5608.2 5685.9 5835.0 5845.6 5871.6 5878.6 5750.2 5750.6 5762.1 5762.7 5766.5 5594.0 5597.9 5598.4 5602.0 5603.3 3839.7 3872.5 3872.7 3874.7 3875.7 5719.5 5872.5 5883.1 5884.5 5889.4 5660.6 5663.2 5666.4 5671.8 5677.7 5662.9 5664.7 5668.1 5678.5 5678.8 5377.4 5523.9 5544.8 5551.2 5555.6 5687.3 5698.0 5698.7 5699.8 5707.7 5454.0 5533.8 5541.3 5543.2 5547.7 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12430.49 Median:44323.78 stddev:13974.17 (31.5%) stddev-sans-first:13985.67 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: Values: 715.1 750.4 780.6 791.4 806.9 11409.0 12964.5 13243.1 13257.9 13262.7 13820.4 13908.2 13926.5 13942.4 13947.2 638.1 644.5 793.8 800.1 808.2 813.6 814.6 819.0 821.2 821.4 835.5 845.2 845.4 846.3 846.4 666.5 673.6 835.9 845.8 848.9 623.8 626.2 626.4 626.4 626.9 11738.5 11747.4 11793.4 11922.5 11927.5 10907.0 11027.7 11095.7 11104.1 11417.3 9387.7 9456.6 9461.2 9613.4 9686.7 3179.1 3229.0 3257.7 3292.7 3300.8 42580.1 42601.6 42882.4 42917.0 42942.6 8753.2 8905.4 9029.2 9091.5 9113.4 16430.8 16447.2 16453.2 16483.5 16488.1 6224.3 6278.3 6408.9 6456.3 6469.4 3509.5 3540.7 3601.6 3663.8 3719.6 2717.4 2739.9 2746.9 2750.0 2751.8 476.5 477.6 483.4 483.5 485.7 596.5 598.3 602.9 610.8 616.9 7884.9 8325.0 8709.8 8714.2 8868.3 451.5 466.7 469.3 471.5 626.6 3548.0 3548.4 3696.1 3734.4 3754.5 49803.3 50506.7 50561.5 50901.0 50923.5 43907.1 44216.6 44431.0 44450.0 44617.6 40336.4 41196.0 41274.8 41573.4 42451.9 6920.9 7325.2 7353.2 7411.4 7439.5 30466.0 30495.5 30754.5 30808.2 30943.4 37232.6 37253.4 37335.3 40913.6 41204.0 9605.5 10004.9 10065.7 10269.9 10288.3 11294.4 11344.2 11613.7 11657.5 11775.4 10450.4 10516.2 10562.3 10599.3 10814.9 10903.6 10908.9 11017.5 11044.0 11496.0 10895.4 11098.5 11127.1 11309.9 11589.8 9110.2 9203.0 9377.1 9499.0 9633.4 8628.7 8867.7 8969.4 9175.0 9299.3 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:23:55 INFO - 2015-12-06 14:23:55,271 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2015-12-06 14:23:55,971 INFO : Browser exited with error code: 0 14:23:55 INFO - 2015-12-06 14:23:55,992 INFO : Completed test dromaeo_css (00:18:37) 14:23:55 INFO - 2015-12-06 14:23:55,992 INFO : Starting test kraken 14:23:55 INFO - 2015-12-06 14:23:55,992 DEBUG : operating with platform_type : linux_ 14:23:55 INFO - 2015-12-06 14:23:55,992 INFO : Initialising browser for kraken test... 14:23:55 INFO - 2015-12-06 14:23:55,998 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9zBOiC/profile http://localhost:60720/getInfo.html 14:24:00 INFO - 2015-12-06 14:24:00,236 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:24:00 INFO - 2015-12-06 14:24:00,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:24:00 INFO - 2015-12-06 14:24:00,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:24:00 INFO - 2015-12-06 14:24:00,236 DEBUG : BROWSER_OUTPUT: __metrics 14:24:00 INFO - 2015-12-06 14:24:00,284 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:24:00 INFO - 2015-12-06 14:24:00,345 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:01 INFO - 2015-12-06 14:24:01,267 INFO : Browser initialized. 14:24:01 INFO - 2015-12-06 14:24:01,268 INFO : Running cycle 1/1 for kraken test... 14:24:01 INFO - 2015-12-06 14:24:01,268 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9zBOiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:24:13 INFO - 2015-12-06 14:24:13,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 141930496 14:24:13 INFO - 2015-12-06 14:24:13,300 DEBUG : BROWSER_OUTPUT: 14:24:15 INFO - 2015-12-06 14:24:15,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60720/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:16 INFO - 2015-12-06 14:24:16,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 176996352 14:24:16 INFO - 2015-12-06 14:24:16,458 DEBUG : BROWSER_OUTPUT: 14:24:19 INFO - 2015-12-06 14:24:19,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60720/tests/kraken/driver.html?testName=audio-dft) 14:24:19 INFO - 2015-12-06 14:24:19,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 166866944 14:24:19 INFO - 2015-12-06 14:24:19,757 DEBUG : BROWSER_OUTPUT: 14:24:22 INFO - 2015-12-06 14:24:22,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60720/tests/kraken/driver.html?testName=audio-fft) 14:24:23 INFO - 2015-12-06 14:24:23,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 154849280 14:24:23 INFO - 2015-12-06 14:24:23,276 DEBUG : BROWSER_OUTPUT: 14:24:25 INFO - 2015-12-06 14:24:25,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60720/tests/kraken/driver.html?testName=audio-oscillator) 14:24:25 INFO - 2015-12-06 14:24:25,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 154992640 14:24:25 INFO - 2015-12-06 14:24:25,927 DEBUG : BROWSER_OUTPUT: 14:24:28 INFO - 2015-12-06 14:24:28,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:28 INFO - 2015-12-06 14:24:28,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 157143040 14:24:28 INFO - 2015-12-06 14:24:28,739 DEBUG : BROWSER_OUTPUT: 14:24:31 INFO - 2015-12-06 14:24:31,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60720/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:32 INFO - 2015-12-06 14:24:32,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 159264768 14:24:32 INFO - 2015-12-06 14:24:32,349 DEBUG : BROWSER_OUTPUT: 14:24:35 INFO - 2015-12-06 14:24:35,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60720/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:36 INFO - 2015-12-06 14:24:36,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 159260672 14:24:36 INFO - 2015-12-06 14:24:36,324 DEBUG : BROWSER_OUTPUT: 14:24:39 INFO - 2015-12-06 14:24:39,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60720/tests/kraken/driver.html?testName=json-parse-financial) 14:24:39 INFO - 2015-12-06 14:24:39,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 158146560 14:24:39 INFO - 2015-12-06 14:24:39,765 DEBUG : BROWSER_OUTPUT: 14:24:41 INFO - 2015-12-06 14:24:41,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:42 INFO - 2015-12-06 14:24:42,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 171196416 14:24:42 INFO - 2015-12-06 14:24:42,119 DEBUG : BROWSER_OUTPUT: 14:24:44 INFO - 2015-12-06 14:24:44,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:44 INFO - 2015-12-06 14:24:44,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 168579072 14:24:44 INFO - 2015-12-06 14:24:44,608 DEBUG : BROWSER_OUTPUT: 14:24:46 INFO - 2015-12-06 14:24:46,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:47 INFO - 2015-12-06 14:24:47,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 179081216 14:24:47 INFO - 2015-12-06 14:24:47,327 DEBUG : BROWSER_OUTPUT: 14:24:49 INFO - 2015-12-06 14:24:49,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:50 INFO - 2015-12-06 14:24:50,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 184643584 14:24:50 INFO - 2015-12-06 14:24:50,483 DEBUG : BROWSER_OUTPUT: 14:24:53 INFO - 2015-12-06 14:24:53,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:53 INFO - 2015-12-06 14:24:53,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 183152640 14:24:53 INFO - 2015-12-06 14:24:53,620 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60720/tests/kraken/driver.html?testName=ai-astar) 14:24:55 INFO - 2015-12-06 14:24:55,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 241680384 14:24:55 INFO - 2015-12-06 14:24:55,633 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,633 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:24:55 INFO - 2015-12-06 14:24:55,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:24:55 INFO - 2015-12-06 14:24:55,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;111;111;112;102;111;110;101 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;137;149;175;130;155;153;130;173;130 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;161;164;160;163;161;161;160 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;83;95;72;75;73;108;94;72 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;134;93;95;94;131;94;95;134 14:24:55 INFO - 2015-12-06 14:24:55,634 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;148;148;148;148;148;146;147 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;96;95;95;96;95 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;70;71;72;72;72;73;72;72;69 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;69;68;69;69;69;69;68 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;83;86;89;83;84;83;85;83 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;123;127;136;120;125;117;129;128;138 14:24:55 INFO - 2015-12-06 14:24:55,635 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;151;154;144;144;132;145;139;140;133 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;70;68;68;68;69;69;68;70 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,981 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: __startTimestamp1449440695628__endTimestamp 14:24:55 INFO - 2015-12-06 14:24:55,636 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:111.00 stddev:4.18 (3.8%) stddev-sans-first:4.43 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 111.0 111.0 112.0 102.0 111.0 110.0 101.0 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,638 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:152.00 stddev:16.77 (11.0%) stddev-sans-first:17.76 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: Values: 151.0 137.0 149.0 175.0 130.0 155.0 153.0 130.0 173.0 130.0 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 161.0 164.0 160.0 163.0 161.0 161.0 160.0 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:74.00 stddev:13.07 (17.7%) stddev-sans-first:13.41 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 83.0 95.0 72.0 75.0 73.0 108.0 94.0 72.0 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.80 (20.0%) stddev-sans-first:19.45 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 134.0 93.0 95.0 94.0 131.0 94.0 95.0 134.0 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,639 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 148.0 148.0 148.0 148.0 148.0 146.0 147.0 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:72.00 stddev:1.26 (1.8%) stddev-sans-first:1.24 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: Values: 73.0 70.0 71.0 72.0 72.0 72.0 73.0 72.0 72.0 69.0 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.73 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 14:24:55 INFO - 2015-12-06 14:24:55,640 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.04 (2.4%) stddev-sans-first:2.17 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 83.0 86.0 89.0 83.0 84.0 83.0 85.0 83.0 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.50 stddev:6.53 (5.1%) stddev-sans-first:6.86 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: Values: 130.0 123.0 127.0 136.0 120.0 125.0 117.0 129.0 128.0 138.0 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.00 stddev:7.09 (4.9%) stddev-sans-first:7.37 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: Values: 138.0 151.0 154.0 144.0 144.0 132.0 145.0 139.0 140.0 133.0 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 70.0 68.0 68.0 68.0 69.0 69.0 68.0 70.0 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:24:55 INFO - 2015-12-06 14:24:55,641 DEBUG : BROWSER_OUTPUT: 14:24:56 INFO - 2015-12-06 14:24:56,563 INFO : Browser exited with error code: 0 14:24:56 INFO - 2015-12-06 14:24:56,614 INFO : Completed test kraken (00:01:00) 14:24:56 INFO - 2015-12-06 14:24:56,614 INFO : Starting test v8_7 14:24:56 INFO - 2015-12-06 14:24:56,614 DEBUG : operating with platform_type : linux_ 14:24:56 INFO - 2015-12-06 14:24:56,614 INFO : Initialising browser for v8_7 test... 14:24:56 INFO - 2015-12-06 14:24:56,620 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3KW2X/profile http://localhost:60720/getInfo.html 14:25:00 INFO - 2015-12-06 14:25:00,817 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:25:00 INFO - 2015-12-06 14:25:00,817 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:25:00 INFO - 2015-12-06 14:25:00,817 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:25:00 INFO - 2015-12-06 14:25:00,817 DEBUG : BROWSER_OUTPUT: __metrics 14:25:00 INFO - 2015-12-06 14:25:00,885 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:25:00 INFO - 2015-12-06 14:25:00,953 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:01 INFO - 2015-12-06 14:25:01,739 INFO : Browser initialized. 14:25:01 INFO - 2015-12-06 14:25:01,740 INFO : Running cycle 1/1 for v8_7 test... 14:25:01 INFO - 2015-12-06 14:25:01,740 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3KW2X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:25:13 INFO - 2015-12-06 14:25:13,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 142942208 14:25:13 INFO - 2015-12-06 14:25:13,740 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60720/tests/v8_7/run.html (next: http://localhost:60720/tests/v8_7/run.html) 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 452550656 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:25:35 INFO - 2015-12-06 14:25:35,503 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |0;Richards;165.50810989738497 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.90816136828406 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |6;Boyer;12023.809523809523 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |8;Splay;595.2802359882006 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: __startTimestamp1449440735496__endTimestamp 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:25:35 INFO - 2015-12-06 14:25:35,504 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 165.5 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.91 Median:185.91 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 185.9 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 277.9 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 5117.3 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 2006.0 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,505 DEBUG : BROWSER_OUTPUT: Values: 783.7 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: Values: 12023.8 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: Values: 26868.4 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.28 Median:595.28 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: Values: 595.3 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:25:35 INFO - 2015-12-06 14:25:35,506 DEBUG : BROWSER_OUTPUT: 14:25:36 INFO - 2015-12-06 14:25:36,395 INFO : Browser exited with error code: 0 14:25:36 INFO - 2015-12-06 14:25:36,409 INFO : Completed test v8_7 (00:00:39) 14:25:36 INFO - 2015-12-06 14:25:36,424 INFO : Completed test suite (00:20:17) 14:25:36 INFO - 2015-12-06 14:25:36,425 DEBUG : Working with test: dromaeo_css 14:25:36 INFO - 2015-12-06 14:25:36,425 DEBUG : Generating results file: dromaeo_css 14:25:36 INFO - 2015-12-06 14:25:36,426 DEBUG : Working with test: kraken 14:25:36 INFO - 2015-12-06 14:25:36,426 DEBUG : Generating results file: kraken 14:25:36 INFO - 2015-12-06 14:25:36,426 INFO : javascript benchmark 14:25:36 INFO - 2015-12-06 14:25:36,426 DEBUG : Working with test: v8_7 14:25:36 INFO - 2015-12-06 14:25:36,427 DEBUG : Generating results file: v8_7 14:25:36 INFO - 2015-12-06 14:25:36,427 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:36 INFO - 2015-12-06 14:25:36,585 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 14:25:36 INFO - 2015-12-06 14:25:36,585 DEBUG : process_Request line: dromaeo_css 6199.76 graph.html#tests=[[72,132,35]] 14:25:36 INFO - 2015-12-06 14:25:36,585 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:36 INFO - 2015-12-06 14:25:36,700 DEBUG : process_Request line: kraken 1519.30 graph.html#tests=[[232,132,35]] 14:25:36 INFO - 2015-12-06 14:25:36,700 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:36 INFO - 2015-12-06 14:25:36,731 DEBUG : process_Request line: v8_7 19898.60 graph.html#tests=[[230,132,35]] 14:25:36 INFO - 2015-12-06 14:25:36,733 INFO : javascript benchmark 14:25:36 INFO - 2015-12-06 14:25:36,736 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.032807861091, 2703.040420650669, 2713.2402927180397, 2717.605947137665, 2733.275681944285, 4552.203364411232, 4650.302454631803, 4688.976555117229, 4712.740799256039, 4720.952790472094, 4562.429696287964, 4603.964108075681, 4686.601638860701, 4688.2733176357715, 4707.811687532503, 4270.210011147948, 4273.87178384649, 4349.2606256936315, 4372.759498227596, 4392.12157568486, 4335.848245311415, 4371.431713877191, 4396.186705459484, 4397.626201772837, 4446.688731788776, 4132.276851550967, 4221.620054195107, 4233.894152646178, 4247.129338485603, 4357.172137293904, 4324.718893271927, 4329.242382583036, 4331.956680433187, 4340.956590434087, 4366.454193225847, 4300.763458009808, 4315.266404711207, 4324.610785029363, 4341.826326946918, 4355.433793606842, 4411.492678341968, 4536.160810250114, 4540.8864778380475, 4616.930746038812, 4731.716097034189, 4973.353464049686, 5057.140286151363, 5058.949410505885, 5065.848024559269, 5102.0, 5078.289039534431, 5080.517350851663, 5085.0, 5092.643514953955, 5121.564667003309, 4557.498675145731, 4676.041411510632, 4691.507391723888, 4703.529647035338, 4824.179889418737, 5237.3453318335205, 5278.97360513195, 5286.36563612369, 5289.047971365191, 5290.100682883919, 5072.847814565569, 5077.543021128116, 5077.543021128116, 5080.796768129308, 5128.076946149728, 4787.2101103318255, 4890.853274401774, 4891.095147397672, 4973.079980203674, 5073.061483625541, 4995.575376093073, 5035.62232832539, 5036.169032109734, 5037.672551284155, 5095.133827249377, 5010.799568017239, 5014.52362025607, 5015.824446144367, 5017.523335283142, 5021.0, 3677.2645470905927, 3707.8146092695797, 3718.163413232001, 3829.0235989822418, 3917.9216415671526, 3487.5814902211896, 3491.4937334086417, 3515.7538972271695, 3523.418635925095, 3529.0, 4367.344898265285, 4372.540883207281, 4372.650187984954, 4374.562543745664, 4411.84558540456, 4775.904481910342, 4879.878003049952, 4881.487443818419, 4990.476000020019, 5029.270755740397, 4345.782710864444, 4347.978260108743, 4349.608535231844, 4368.563143685606, 4373.890652733643, 4445.444319460067, 4457.24226881431, 4457.509673935864, 4460.687751857339, 4496.437945256843, 4602.539746025371, 4711.552402521892, 4712.59942904857, 4732.597729193058, 4849.102915960488, 5093.388793344822, 5102.0, 5109.3613298337705, 5114.15616423286, 5131.409887862944, 4862.07620552094, 4865.489123641966, 4868.050730107595, 4869.4400143982475, 4901.90196196067, 4739.739314337745, 4850.587700045536, 4854.757262136808, 4857.295692124551, 5075.3402057732255, 5074.797008119634, 5079.568236699922, 5081.491850815037, 5081.92377114351, 5125.8974820502635, 4922.4339200992345, 4925.1873440881855, 4925.852224433273, 4926.753662316942, 4963.602911766978, 4689.882752931204, 4714.269288260325, 4775.474697783172, 4783.282507623884, 4966.652334336562, 4772.403449568804, 4781.856544303677, 4799.736014519235, 4834.8791280216865, 4871.464138944784, 4918.95081049185, 4919.508049195052, 4919.557239848287, 4923.753812309298, 4970.030843985533, 4570.451545814523, 4600.355950167046, 4651.279051746985, 4655.743934083658, 4854.75726213695], "unit": "ms", "name": "dojo.html", "value": 4589.205310549222}, {"lowerIsBetter": false, "replicates": [573.1431509892711, 575.0999685492204, 577.4225774225777, 582.7086456771614, 584.777784441912, 29347.413051738953, 30065.0, 38762.224755504874, 39131.21737565247, 39224.60775392245, 42236.78881605595, 42775.35836962448, 42809.14381712364, 42847.78576107123, 42878.35682464758, 7147.178074521445, 7278.563286202845, 7919.287264146211, 8097.716579919704, 8102.918970810276, 9847.310688251826, 10070.194384449263, 10071.395716257011, 10073.496325183749, 10074.89925100747, 9690.127888490035, 9835.70492885211, 9836.70489885301, 9844.0, 9847.803043939117, 7373.446991475634, 7548.094228692592, 9741.269404794633, 10439.530221140067, 10698.090662293715, 9888.653897113567, 9984.700458986243, 9987.300888937778, 9995.0, 9996.150327222194, 38895.0, 39209.411858821855, 39304.60695393038, 39331.0, 39437.80281098576, 2676.585129304961, 2857.6856545779947, 3151.448496513101, 3220.4203243416177, 3353.8658453661824, 28105.85947070272, 28321.15036548907, 28361.14916552507, 28448.146555603365, 28552.857235713687, 3398.5921689397182, 3442.535257740223, 3451.5340429042008, 3496.615372309044, 3536.0806190390686, 224196.0, 224609.0, 224833.0, 225104.48955104523, 225167.0, 56420.30739077834, 56729.0, 56849.0, 56886.43113568894, 56905.430945690016, 49045.5095449041, 50602.74698626557, 60071.69964150151, 60190.69904650536, 60250.0, 12730.299833509062, 12743.171693839871, 12816.743665126645, 12819.679508012188, 12865.549705760253, 9580.904190958141, 9617.71146865595, 9628.085331893459, 9629.855552166724, 9633.08485693858, 18855.0, 19329.710054349194, 19335.51661208481, 19353.612927741367, 19368.0, 7126.750563730245, 7248.746293879794, 7270.0, 7373.373263272575, 7384.815379615553, 876.5398165962921, 909.6497848328441, 924.4822899176482, 978.496074521622, 989.0159291504999, 26583.601245981325, 26636.80134393957, 27488.45023099527, 28967.275818104295, 30296.5455518163, 946.6402766948515, 956.8899576548786, 1027.3117011602094, 1051.30613794895, 1095.1403148528368, 13514.391852366667, 13607.909553713691, 13872.583822485341, 13876.791848122286, 13963.162210267417, 260448.0, 265617.0, 266043.0, 266182.0, 266287.0, 46567.534324657, 46866.29700554494, 46902.296465553045, 46905.0, 46909.53090469052, 1205.1744554979866, 1207.106741011645, 1221.975560488803, 1228.2569045727384, 1231.5073970411906, 25356.619650705623, 25609.0, 25848.353791155372, 26298.21105366842, 26395.0, 41563.37654935239, 41763.0, 41799.37300940549, 41910.58089419189, 41941.0, 236519.0, 241789.0, 248178.0, 250447.0, 335611.0, 28139.43721125607, 28388.574171387034, 28450.14649560434, 28548.714512854607, 28699.569506457003, 38786.93205844483, 38828.80585597054, 39884.401733973435, 39898.40152397774, 40012.199756004135, 33568.32158392119, 33597.0, 34177.82911085528, 34194.0, 34658.306833862676, 32760.50859237161, 34227.0, 34570.0, 34782.0, 34821.30357392787, 30609.0, 31240.21899452532, 31245.37509249757, 31423.371532568763, 31572.526412104296, 28261.43477130487, 30162.547561786152, 30572.929947451732, 30627.2343191422, 30792.381142828755, 24489.51020979606, 25555.74444255608, 25575.872120639277, 25585.48829023372, 25849.612255815802], "unit": "ms", "name": "ext.html", "value": 17373.89207959128}, {"lowerIsBetter": false, "replicates": [327.9237404971048, 328.50559907339454, 329.73456367624055, 330.93050459403526, 333.6130089096648, 12374.876251237485, 12770.872291277085, 14957.5512734618, 15243.542693719191, 15377.923110384447, 11688.941555292211, 13299.734005319888, 13402.865971340283, 13459.932700336509, 13539.661508462294, 3666.4683620874957, 4763.833265835697, 4775.379200703912, 4900.215965445529, 4919.0, 3582.283543291339, 3669.3945498992634, 4848.490908454614, 4907.2639104134305, 5522.199281104237, 5499.340079190502, 5534.584906132056, 5576.191452239423, 5623.0721930881355, 5629.7185140742795, 4847.2002119650215, 5000.974995125001, 5008.1486147355035, 5008.449070602231, 5523.25436066132, 4675.158471475133, 4812.109759694467, 4828.903421931577, 4831.4202295724735, 4974.77613507393, 11318.377489238088, 11449.771004579945, 11496.137789665809, 11502.539898404053, 14564.490242841555, 1742.0418769676628, 1763.938262160831, 1766.2316892151828, 1776.6180271241744, 1830.6247219320007, 8483.533405662685, 8486.575671216477, 8738.082501337396, 8975.41659792118, 9067.365284430092, 1579.2261791721974, 1630.9102999335032, 1689.06257027351, 1743.0500377294404, 1749.0, 55761.44238557603, 56413.717931410494, 57564.712176439265, 58485.41514584842, 59040.11439828406, 9355.719328420022, 9693.806123877483, 9725.0761177688, 9806.75483112928, 9817.723695919485, 12427.813582796265, 12437.191582547106, 12448.75102497963, 12453.564125255572, 12457.501699931901, 6696.631685257357, 6736.955771855371, 6845.452363810883, 6890.483213758988, 6923.826904327432, 6422.775202867971, 6462.159919210472, 6549.476041916635, 6626.0, 6631.502637302222, 4068.8372465101065, 4238.21593005295, 4245.80893859777, 4261.552536983634, 4268.551802060801, 1585.3658536585458, 1646.168684814185, 1648.4807285705203, 1691.1797778077623, 1725.1288099509668, 358.1279584212451, 358.76680157897573, 746.9365103966115, 817.1787353709602, 823.555280148713, 9484.099010593982, 9988.750281242881, 10288.382697038202, 10293.43386113771, 10336.5348559315, 347.5481873564407, 366.417396339821, 389.1943676589433, 392.61915941536665, 397.4118304908751, 5235.921461178085, 5326.733663316819, 5401.02781499326, 5443.727813609304, 5484.2596249506605, 450389.0, 472408.0, 473959.0, 481050.0, 485672.0, 71845.0, 72195.63902180456, 73483.63258183675, 74218.6289068562, 74581.0, 419.35210100394966, 424.85554911330297, 425.0351701637266, 425.07334011854454, 425.5446672060927, 9396.624135034523, 9410.482423466776, 9477.431354118775, 9511.0, 9538.427694338361, 29816.850915745283, 30989.535156973114, 31267.51697366639, 31372.843135784176, 31614.36771264608, 41610.58389416067, 42738.57261427346, 42977.78511107424, 43645.56354436415, 44139.0, 8701.956490217508, 8793.252573531321, 8864.335174861782, 8944.88188976378, 8952.910470895207, 10417.479126043516, 15177.848221517643, 15388.84611153919, 15414.84585154134, 15467.922660386626, 13391.129576577492, 13779.517716880262, 13808.585742427744, 13825.308734563432, 14133.575992720234, 12677.239365638092, 13014.739705205653, 13196.934015329862, 13253.602391928258, 13523.323833808467, 10498.160147188359, 12285.508579657071, 13342.0, 13940.233287168898, 14184.36170372315, 8891.155340242667, 8930.19628233462, 9135.543222838964, 9150.359474836698, 9177.082291771036, 13945.651358716113, 13993.230372329212, 14108.365123569669, 14129.0, 14359.856401435853], "unit": "ms", "name": "jquery.html", "value": 7274.80525686373}, {"lowerIsBetter": false, "replicates": [1454.5418193269113, 1709.358990378608, 1749.5888466210438, 1778.4131236691892, 1783.8662100342478, 5984.28188617366, 7196.208417074117, 7400.0, 7402.629868506567, 7406.703731850733, 7200.891986620205, 7354.742584009561, 7358.595277259748, 7358.926410735891, 7364.815879603013, 2021.161218094489, 2071.2439959414783, 2071.968920466194, 2073.39871437283, 2073.637113505138, 2067.1111422088497, 2081.032319971213, 2092.257248676721, 2120.4592828828704, 2121.087932189158, 2020.535276886317, 2043.3563427520357, 2053.3326668832688, 2054.4452997690614, 2055.3320170944503, 2051.7845626209255, 2072.3782865140397, 2073.906674199665, 2074.678424844152, 2075.1595603780493, 2016.5765189310262, 2030.4720772599082, 2058.3310424112224, 2060.9896950515304, 2061.7319748432756, 7257.092863392076, 7344.742933997338, 7349.63251837406, 7354.154272258652, 7357.0, 4062.1672557125717, 4127.587241275878, 4128.236276288866, 4128.380742888561, 4131.9173616527805, 2626.2909014566153, 2644.8809803558693, 2672.8930842766267, 2687.4490729400427, 2704.8512331821744, 858.5750053723447, 869.6043300298412, 879.0, 884.0275696733606, 905.7011186308503, 9966.9501652492, 9981.60073597048, 9987.250956178243, 9987.950060249725, 10003.299769016172, 3854.5567259764925, 3875.8837234883, 3915.158240978203, 3935.763854168759, 3935.7835319057726, 8624.95687521571, 8627.956860215785, 8638.438501497383, 8643.827123457495, 8656.913430865736, 4182.477190351206, 4198.181354635878, 4205.516365617932, 4205.600467955601, 4206.053637931441, 3082.969170308268, 3153.132888455693, 3627.2564124354444, 3763.1156678180605, 3779.829907654162, 3367.5285460035616, 3416.0947348952545, 3444.4144495435835, 3452.602950660656, 3464.047386968604, 1051.5163025008428, 1057.0539367266254, 1057.8836328003913, 1080.6055789636882, 1092.2299778656188, 1144.1704764046167, 1161.7618388230392, 1166.8658104317942, 1207.7584483103415, 1243.1670780577035, 6767.323267673291, 6917.861642767117, 6932.618705971119, 6951.0, 6965.930340696629, 397.1600065860684, 400.01995111975776, 401.18158955730564, 401.84930651005874, 402.16751324758053, 5343.145096784574, 5413.323334583177, 5424.701641409761, 5432.809851655173, 5435.83692489226, 8726.214640682369, 8740.650373985096, 8795.384323097449, 8912.910870891337, 8956.641734330684, 8773.517456539825, 8818.074102219174, 8874.778130546789, 8887.955560222286, 8905.910940890637, 6852.931470685229, 6859.211190713132, 6970.163580370388, 6986.301369862973, 7025.192102908231, 6621.635810030494, 6707.128073350434, 6713.160854893138, 6715.597064176165, 6724.4620430364475, 7799.936626133762, 7900.644470998704, 7921.603919804102, 7990.560519171501, 8024.719134830253, 8069.556174410463, 8129.67481300765, 8138.104808470945, 8231.053428855757, 8282.544460054754, 5526.143447765603, 5701.059325211294, 6212.782552610637, 6403.3276505966205, 6437.67811609427, 6920.757773477904, 6928.203256625553, 6928.445724342141, 6948.166220053626, 6969.860602788017, 6357.268914074941, 6522.445592124533, 6566.967165164144, 6576.441002514648, 6669.166354205724, 6355.364463553793, 6485.935140648533, 6486.318936511599, 6498.0252962056065, 6531.477481801349, 6374.681265936777, 6391.201099862517, 6399.200099987502, 6414.390632889868, 6424.775132870327, 5565.3599836019375, 5681.204631351531, 5695.772169113189, 5823.242978412779, 5872.119182122716, 5980.730867111078, 6024.789132380346, 6040.305364883095, 6040.335563088145, 6059.212302400836], "unit": "ms", "name": "mootools.html", "value": 4042.492848544896}, {"lowerIsBetter": false, "replicates": [274.54288609465243, 279.2780661988759, 279.7356498109287, 282.87270728172314, 288.1801275371567, 5338.306020217376, 5371.731413429327, 5431.103867861803, 5431.701256430894, 5450.3459584849825, 5221.485769126958, 5331.440198779131, 5344.038073146832, 5348.812791552296, 5370.167624018273, 4130.194612050651, 4139.855105071308, 4139.9793001035105, 4148.460700108982, 4151.149014452045, 3907.7069219808486, 4000.639942405183, 4008.5790991945864, 4073.5926407359175, 4092.0997380576227, 3996.3605823068315, 4034.5360283567325, 4041.333180025292, 4043.8180281887385, 4071.063655359269, 3871.8838434846716, 4049.817758200888, 4050.108976025255, 4056.7565946043333, 4069.7965101744794, 3444.328355970587, 3464.6881780639865, 3528.770629909048, 3539.876104336336, 3549.804760738158, 5163.3545806774155, 5168.043911876277, 5175.611829112831, 5179.974100129513, 5188.351456067991, 4672.065586882603, 4680.134175177603, 4680.297955306697, 4683.531646835323, 4685.4143232095985, 5458.181272809111, 5600.383957764642, 5601.383847776741, 5606.915896261559, 5608.691521966291, 3839.2897313996723, 3843.538775346948, 3844.788536630484, 3848.3457812171996, 3854.670138802109, 5849.824505264849, 5927.673977931255, 5934.465898069151, 5940.257467816523, 5940.7920722774925, 3963.6721698231418, 3964.940525892114, 3967.6032396760093, 3969.4442778011103, 3969.503812023497, 4019.1559772448113, 4023.839046438168, 4026.4564283821896, 4034.334334834778, 4036.0313524753847, 4486.439195100613, 4638.512956139624, 4660.13787449323, 4692.460367057832, 4692.507286734912, 5638.520725738276, 5643.5203007743985, 5648.15277708347, 5655.0, 5661.377248502661, 1398.5664444022182, 1419.1130543410368, 1419.815423994874, 1419.872211500949, 1420.2330741399735, 919.048784508031, 919.3932004876749, 931.8276118918022, 947.3889341374775, 949.0888746803008, 4955.529224723646, 4962.0, 4962.553370196628, 4966.230234313687, 4966.279889416014, 5855.297364316224, 5864.354920958691, 5866.0, 5867.090600956859, 5870.031444811559, 4947.529984651453, 4956.479569645136, 4958.801647934042, 4959.082569724613, 4959.776810043557, 3068.5397190421168, 3121.9687803122133, 3155.4477966355794, 3159.178613560445, 3161.9051428457183, 5404.486573775485, 5462.371827239839, 5535.086710692691, 5615.803446879339, 5625.915611265835, 6054.909176362358, 6057.273127224761, 6059.333473317932, 6063.090536419572, 6069.2716873975405, 5595.356533998561, 5595.860103497445, 5600.803971860965, 5603.635763675348, 5608.2148499209325, 5685.943140568541, 5835.0, 5845.561582881216, 5871.647701137946, 5878.588498805214, 5750.166225897305, 5750.568707346882, 5762.135679648086, 5762.6830524319885, 5766.481016708516, 5593.972030139823, 5597.860053498533, 5598.384177740364, 5601.971990140186, 5603.299587551556, 3839.6544311012144, 3872.5159355080614, 3872.6514613684903, 3874.748141370802, 3875.748076375027, 5719.456651618089, 5872.530197584098, 5883.117532370179, 5884.47039766423, 5889.381614930542, 5660.575456840671, 5663.235463212578, 5666.405027472056, 5671.773129074791, 5677.7161141941915, 5662.886742265214, 5664.745086471036, 5668.064769313017, 5678.545716342765, 5678.801241956512, 5377.354717433933, 5523.944760552504, 5544.750486228048, 5551.195076713773, 5555.583331250254, 5687.317521897398, 5697.971510142423, 5698.743556539883, 5699.772009119589, 5707.68607726579, 5454.0, 5533.750981205775, 5541.33503979525, 5543.223948647112, 5547.667139971614], "unit": "ms", "name": "prototype.html", "value": 4194.959360844726}, {"lowerIsBetter": false, "replicates": [715.1168307140683, 750.3734381791204, 780.6096951524238, 791.3708601661676, 806.854766142095, 11409.0, 12964.546240881571, 13243.139195952257, 13257.939364850812, 13262.668433289173, 13820.378082986264, 13908.235047072432, 13926.51257205998, 13942.372593233304, 13947.232902190375, 638.0716058135425, 644.4940721533598, 793.8015496125954, 800.0559339978822, 808.1796976069265, 813.6135335715547, 814.6374863185855, 819.0212695828487, 821.1788211788212, 821.4208982667205, 835.4903508859591, 845.2266176448542, 845.3533047218851, 846.3102571404286, 846.4413487098516, 666.4868051600265, 673.6126727131895, 835.9038710548303, 845.8223773007676, 848.9405741598091, 623.7941479311861, 626.2234828812285, 626.3986572890032, 626.4111734969115, 626.9341719119473, 11738.47176877034, 11747.412629368582, 11793.410329483491, 11922.463489142923, 11927.463264153133, 10907.0, 11027.72430689231, 11095.667129986114, 11104.111671066295, 11417.257878237888, 9387.718368448957, 9456.621735130586, 9461.24310055194, 9613.375130616558, 9686.70939871805, 3179.093958221919, 3228.96771032289, 3257.7230935370285, 3292.670732926712, 3300.8349582520777, 42580.14839703219, 42601.57398425976, 42882.35676464855, 42917.0, 42942.570574294485, 8753.212210901049, 8905.376623636414, 9029.187373136449, 9091.454512729126, 9113.407628504126, 16430.75353869693, 16447.177641118134, 16453.177341132894, 16483.505494835175, 16488.0931548766, 6224.346443623354, 6278.30938596754, 6408.935910640927, 6456.289808121103, 6469.385408386196, 3509.4560343146854, 3540.7344449166417, 3601.63088980595, 3663.7618554793853, 3719.5722491913234, 2717.3885875677815, 2739.8630068496495, 2746.9038583649476, 2749.986250068737, 2751.834889906612, 476.4906463893469, 477.60597507056815, 483.41506776800463, 483.50440798182143, 485.67702477851833, 596.5138412194048, 598.3209057719432, 602.8914795336882, 610.8472881779555, 616.8612062286039, 7884.921150788534, 8325.0, 8709.782255443537, 8714.21572058505, 8868.290536757044, 451.4965813118349, 466.6803239780761, 469.26325668699815, 471.549670065087, 626.6083697688945, 3547.9645203547634, 3548.379033669149, 3696.094456858087, 3734.3651579231596, 3754.4931434256573, 49803.25295120576, 50506.74746626243, 50561.49438505568, 50901.0, 50923.49076509262, 43907.12185756331, 44216.55783442189, 44431.0, 44450.0, 44617.55382446199, 40336.39495407571, 41196.0, 41274.79362603168, 41573.376399354034, 42451.93870153333, 6920.861582768417, 7325.194228634952, 7353.196040662825, 7411.4070874328845, 7439.479236453396, 30466.0, 30495.542566861957, 30754.538681920236, 30808.229794255323, 30943.381132377675, 37232.627673724, 37253.441198382585, 37335.25329493449, 40913.59086409098, 41204.0, 9605.47169905634, 10004.899951000396, 10065.748356290858, 10269.948650256702, 10288.331258468175, 11294.43527823622, 11344.20590558653, 11613.6515904523, 11657.53369865196, 11775.352355620524, 10450.42522661261, 10516.158707303244, 10562.260641755003, 10599.311044782064, 10814.891851081704, 10903.618373356894, 10908.945455272673, 11017.504212310305, 11044.0, 11496.0, 10895.400752958663, 11098.500567474644, 11127.109831213646, 11309.886901130883, 11589.768204636028, 9110.180083792491, 9202.953985230299, 9377.1091746284, 9499.0, 9633.42199468006, 8628.741137765877, 8867.689630863148, 8969.372143950122, 9175.0, 9299.302552308469], "unit": "ms", "name": "yui.html", "value": 5772.599558047728}], "name": "dromaeo_css", "value": 6199.760882272119}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 111.0, 111.0, 112.0, 102.0, 111.0, 110.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [151.0, 137.0, 149.0, 175.0, 130.0, 155.0, 153.0, 130.0, 173.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 164.0, 160.0, 163.0, 161.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 83.0, 95.0, 72.0, 75.0, 73.0, 108.0, 94.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 93.0, 95.0, 94.0, 131.0, 94.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 71.0, 72.0, 72.0, 72.0, 73.0, 72.0, 72.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 86.0, 89.0, 83.0, 84.0, 83.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [130.0, 123.0, 127.0, 136.0, 120.0, 125.0, 117.0, 129.0, 128.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [138.0, 151.0, 154.0, 144.0, 144.0, 132.0, 145.0, 139.0, 140.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1519.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [185.90816136828406], "unit": "score", "name": "DeltaBlue", "value": 355.64872200000013}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12023.809523809523], "unit": "score", "name": "Boyer", "value": 55.42860594059401}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [595.2802359882006], "unit": "score", "name": "Splay", "value": 136.89518830525276}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19898.59674502315}]} 14:25:36 INFO - RETURN: dromaeo_css: 6199.76 14:25:36 INFO - RETURN: kraken: 1519.30 14:25:36 INFO - RETURN: v8_7: 19898.60 14:25:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19898.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1519.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6199.76"}}} 14:25:36 INFO - Return code: 0 14:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:36 INFO - # TBPL SUCCESS # 14:25:36 INFO - Running post-action listener: _resource_record_post_action 14:25:36 INFO - Running post-run listener: _resource_record_post_run 14:25:37 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 12288; Write bytes: 527110144; Read time: 472; Write time: 527108 14:25:37 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 248328192; Read time: 228; Write time: 355400 14:25:37 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 277917696; Read time: 244; Write time: 171660 14:25:37 INFO - Running post-run listener: _upload_blobber_files 14:25:37 INFO - Blob upload gear active. 14:25:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:25:37 INFO - Copying logs to upload dir... 14:25:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.551566 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-06 14:25:37.140254) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-06 14:25:37.143942) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010124 build_url: 'https://queue.taskcluster.net/v1/task/csrEaqMJQPqe4FOMOHa2TA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-06 14:25:37.195716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:25:37.196049) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449418378.702028-1390671997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-06 14:25:37.246475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-06 14:25:37.246804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-06 14:25:37.247158) ========= ========= Total master_lag: 0.26 =========