builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1450291957.59 results: success (0) buildid: 20151216101638 builduid: 4ddea214f0504159a8a0964a9c03c039 revision: 7489db357bd48b2bd1751b474c3a91cfa55a9420 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.591824) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.592349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.592678) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006391 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.619694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.620359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.639209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.639556) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 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-16 10:52:37.700663) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.701006) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.701434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.701774) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 10:52:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.6M=0s 2015-12-16 10:52:38 (72.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.832384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.833022) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021227 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:37.907367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 10:52:37.907766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7489db357bd48b2bd1751b474c3a91cfa55a9420 --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 7489db357bd48b2bd1751b474c3a91cfa55a9420 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 10:52:38,722 truncating revision to first 12 chars 2015-12-16 10:52:38,722 Setting DEBUG logging. 2015-12-16 10:52:38,722 attempt 1/10 2015-12-16 10:52:38,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7489db357bd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 10:52:39,773 unpacking tar archive at: fx-team-7489db357bd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326511 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 10:52:39.276714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:39.277263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:39.289906) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:39.290209) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:52:39.290634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-16 10:52:39.290959) ========= /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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:40 INFO - MultiFileLogger online at 20151216 10:52:40 in /builds/slave/test 10:52:40 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 10:52:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:40 INFO - {'append_to_log': False, 10:52:40 INFO - 'base_work_dir': '/builds/slave/test', 10:52:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:40 INFO - 'branch': 'Fx-Team-Non-PGO', 10:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:40 INFO - 'config_files': ('talos/linux_config.py',), 10:52:40 INFO - 'default_actions': ('clobber', 10:52:40 INFO - 'read-buildbot-config', 10:52:40 INFO - 'download-and-extract', 10:52:40 INFO - 'populate-webroot', 10:52:40 INFO - 'create-virtualenv', 10:52:40 INFO - 'install', 10:52:40 INFO - 'run-tests'), 10:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:40 INFO - 'download_minidump_stackwalk': True, 10:52:40 INFO - 'download_symbols': 'ondemand', 10:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:40 INFO - 'installer_path': 'installer.exe', 10:52:40 INFO - 'log_level': 'info', 10:52:40 INFO - 'log_name': 'talos', 10:52:40 INFO - 'log_to_console': True, 10:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:40 INFO - 'opt_config_files': (), 10:52:40 INFO - 'pip_index': False, 10:52:40 INFO - 'sps_profile': False, 10:52:40 INFO - 'sps_profile_interval': 0, 10:52:40 INFO - 'suite': 'dromaeojs', 10:52:40 INFO - 'system_bits': '64', 10:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:40 INFO - 'title': 'talos-linux64-ix-057', 10:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:40 INFO - 'use_talos_json': True, 10:52:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:40 INFO - 'work_dir': 'build'} 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running clobber step. 10:52:40 INFO - ##### 10:52:40 INFO - Running pre-action listener: _resource_record_pre_action 10:52:40 INFO - Running main action method: clobber 10:52:40 INFO - rmtree: /builds/slave/test/build 10:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:40 INFO - Running post-action listener: _resource_record_post_action 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running read-buildbot-config step. 10:52:40 INFO - ##### 10:52:40 INFO - Running pre-action listener: _resource_record_pre_action 10:52:40 INFO - Running main action method: read_buildbot_config 10:52:40 INFO - Using buildbot properties: 10:52:40 INFO - { 10:52:40 INFO - "properties": { 10:52:40 INFO - "buildnumber": 2221, 10:52:40 INFO - "product": "firefox", 10:52:40 INFO - "script_repo_revision": "production", 10:52:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:52:40 INFO - "repository": "", 10:52:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:52:40 INFO - "buildid": "20151216101638", 10:52:40 INFO - "slavename": "talos-linux64-ix-057", 10:52:40 INFO - "pgo_build": "False", 10:52:40 INFO - "basedir": "/builds/slave/test", 10:52:40 INFO - "project": "", 10:52:40 INFO - "platform": "ubuntu64_hw", 10:52:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:52:40 INFO - "slavebuilddir": "test", 10:52:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:52:40 INFO - "branch": "fx-team", 10:52:40 INFO - "repo_path": "integration/fx-team", 10:52:40 INFO - "stage_platform": "linux64", 10:52:40 INFO - "builduid": "4ddea214f0504159a8a0964a9c03c039", 10:52:40 INFO - "revision": "7489db357bd48b2bd1751b474c3a91cfa55a9420" 10:52:40 INFO - }, 10:52:40 INFO - "sourcestamp": { 10:52:40 INFO - "repository": "", 10:52:40 INFO - "hasPatch": false, 10:52:40 INFO - "project": "", 10:52:40 INFO - "branch": "fx-team-linux64-talos", 10:52:40 INFO - "changes": [ 10:52:40 INFO - { 10:52:40 INFO - "category": null, 10:52:40 INFO - "files": [ 10:52:40 INFO - { 10:52:40 INFO - "url": null, 10:52:40 INFO - "name": "https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 10:52:40 INFO - } 10:52:40 INFO - ], 10:52:40 INFO - "repository": "", 10:52:40 INFO - "rev": "7489db357bd48b2bd1751b474c3a91cfa55a9420", 10:52:40 INFO - "who": "bgrinstead@mozilla.com", 10:52:40 INFO - "when": 1450291923, 10:52:40 INFO - "number": 7367581, 10:52:40 INFO - "comments": "Bug 1226810 - Modifications to pretty-fast after upgrade;r=fitzgen", 10:52:40 INFO - "project": "", 10:52:40 INFO - "at": "Wed 16 Dec 2015 10:52:03", 10:52:40 INFO - "branch": "fx-team-linux64-talos", 10:52:40 INFO - "revlink": "", 10:52:40 INFO - "properties": [ 10:52:40 INFO - [ 10:52:40 INFO - "buildid", 10:52:40 INFO - "20151216101638", 10:52:40 INFO - "Change" 10:52:40 INFO - ], 10:52:40 INFO - [ 10:52:40 INFO - "builduid", 10:52:40 INFO - "4ddea214f0504159a8a0964a9c03c039", 10:52:40 INFO - "Change" 10:52:40 INFO - ], 10:52:40 INFO - [ 10:52:40 INFO - "pgo_build", 10:52:40 INFO - "False", 10:52:40 INFO - "Change" 10:52:40 INFO - ] 10:52:40 INFO - ], 10:52:40 INFO - "revision": "7489db357bd48b2bd1751b474c3a91cfa55a9420" 10:52:40 INFO - } 10:52:40 INFO - ], 10:52:40 INFO - "revision": "7489db357bd48b2bd1751b474c3a91cfa55a9420" 10:52:40 INFO - } 10:52:40 INFO - } 10:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:52:40 INFO - Running post-action listener: _resource_record_post_action 10:52:40 INFO - ##### 10:52:40 INFO - ##### Running download-and-extract step. 10:52:40 INFO - ##### 10:52:40 INFO - Running pre-action listener: _resource_record_pre_action 10:52:40 INFO - Running main action method: download_and_extract 10:52:40 INFO - mkdir: /builds/slave/test/build/tests 10:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:40 INFO - https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/test_packages.json 10:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/test_packages.json 10:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:52:48 INFO - Downloaded 1302 bytes. 10:52:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:52:48 INFO - Using the following test package requirements: 10:52:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'jsshell-linux-x86_64.zip'], 10:52:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:52:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:52:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52:48 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')]} 10:52:48 INFO - https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:58 INFO - Downloaded 21870297 bytes. 10:52:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:52:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:52:59 INFO - Return code: 0 10:52:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:52: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')]} 10:52:59 INFO - https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:53:03 INFO - Downloaded 21870297 bytes. 10:53:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:53:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:53:04 INFO - Return code: 0 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:04 INFO - https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:53:06 INFO - Downloaded 11132052 bytes. 10:53:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:53:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:53:06 INFO - Return code: 0 10:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:06 INFO - https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:53:07 INFO - Downloaded 57774334 bytes. 10:53:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:07 INFO - mkdir: /builds/slave/test/properties 10:53:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:07 INFO - Contents: 10:53:07 INFO - build_url:https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:07 INFO - Running post-action listener: _resource_record_post_action 10:53:07 INFO - Running post-action listener: set_extra_try_arguments 10:53:07 INFO - ##### 10:53:07 INFO - ##### Running populate-webroot step. 10:53:07 INFO - ##### 10:53:07 INFO - Running pre-action listener: _resource_record_pre_action 10:53:07 INFO - Running main action method: populate_webroot 10:53:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:07 INFO - '--tppagecycles', 10:53:07 INFO - '7'], 10:53:07 INFO - 'tests': ['tsvgm']}}, 10:53:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'tests': ['damp', 'tps']}, 10:53:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['damp', 'tps']}, 10:53:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:07 INFO - 'other': {'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'other_l64': {'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:07 INFO - 'ts_paint', 10:53:07 INFO - 'tpaint', 10:53:07 INFO - 'sessionrestore', 10:53:07 INFO - 'sessionrestore_no_auto_restore']}, 10:53:07 INFO - 'svgr': {'tests': ['tsvgx', 10:53:07 INFO - 'tsvgr_opacity', 10:53:07 INFO - 'tart', 10:53:07 INFO - 'tscrollx', 10:53:07 INFO - 'cart']}, 10:53:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['tsvgx', 10:53:07 INFO - 'tsvgr_opacity', 10:53:07 INFO - 'tart', 10:53:07 INFO - 'tscrollx', 10:53:07 INFO - 'cart']}, 10:53:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'tests': ['tp5o']}, 10:53:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'talos_options': ['--e10s'], 10:53:07 INFO - 'tests': ['tp5o']}, 10:53:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'talos_options': ['--xperf_path', 10:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:07 INFO - 'tests': ['tp5n']}, 10:53:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:07 INFO - 'talos_options': ['--e10s', 10:53:07 INFO - '--xperf_path', 10:53:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:07 INFO - 'tests': ['tp5n']}}, 10:53:07 INFO - 'talos.zip': {'path': '', 10:53:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:07 INFO - Running post-action listener: _resource_record_post_action 10:53:07 INFO - ##### 10:53:07 INFO - ##### Running create-virtualenv step. 10:53:07 INFO - ##### 10:53:07 INFO - Running pre-action listener: _resource_record_pre_action 10:53:07 INFO - Running main action method: create_virtualenv 10:53:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:07 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 10:53:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:07 INFO - Using real prefix '/usr' 10:53:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:10 INFO - Installing pip.................done. 10:53:10 INFO - Return code: 0 10:53:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:10 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 10:53:10 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 10:53:10 INFO - Using env: {'DISPLAY': ':0', 10:53:10 INFO - 'HOME': '/home/cltbld', 10:53:10 INFO - 'LANG': 'en_US.UTF-8', 10:53:10 INFO - 'LANGUAGE': 'en_US:en', 10:53:10 INFO - 'LOGNAME': 'cltbld', 10:53:10 INFO - 'MAIL': '/var/mail/cltbld', 10:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:10 INFO - 'MOZ_NO_REMOTE': '1', 10:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:10 INFO - 'NO_EM_RESTART': '1', 10:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:10 INFO - 'PWD': '/builds/slave/test', 10:53:10 INFO - 'SHELL': '/bin/bash', 10:53:10 INFO - 'SHLVL': '1', 10:53:10 INFO - 'TERM': 'linux', 10:53:10 INFO - 'TMOUT': '86400', 10:53:10 INFO - 'USER': 'cltbld', 10:53:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:10 INFO - '_': '/tools/buildbot/bin/python'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 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 10:53:10 INFO - Cleaning up... 10:53:10 INFO - Return code: 0 10:53:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:10 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 10:53:10 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 10:53:10 INFO - Using env: {'DISPLAY': ':0', 10:53:10 INFO - 'HOME': '/home/cltbld', 10:53:10 INFO - 'LANG': 'en_US.UTF-8', 10:53:10 INFO - 'LANGUAGE': 'en_US:en', 10:53:10 INFO - 'LOGNAME': 'cltbld', 10:53:10 INFO - 'MAIL': '/var/mail/cltbld', 10:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:10 INFO - 'MOZ_NO_REMOTE': '1', 10:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:10 INFO - 'NO_EM_RESTART': '1', 10:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:10 INFO - 'PWD': '/builds/slave/test', 10:53:10 INFO - 'SHELL': '/bin/bash', 10:53:10 INFO - 'SHLVL': '1', 10:53:10 INFO - 'TERM': 'linux', 10:53:10 INFO - 'TMOUT': '86400', 10:53:10 INFO - 'USER': 'cltbld', 10:53:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:10 INFO - '_': '/tools/buildbot/bin/python'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 INFO - Downloading/unpacking psutil>=0.7.1 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:53:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:12 INFO - Installing collected packages: psutil 10:53:12 INFO - Running setup.py install for psutil 10:53:12 INFO - building 'psutil._psutil_linux' extension 10:53:12 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 10:53:12 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 10:53:12 INFO - building 'psutil._psutil_posix' extension 10:53:12 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 10:53:13 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 10:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:13 INFO - Successfully installed psutil 10:53:13 INFO - Cleaning up... 10:53:13 INFO - Return code: 0 10:53:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:13 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:13 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 10:53:13 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 10:53:13 INFO - Using env: {'DISPLAY': ':0', 10:53:13 INFO - 'HOME': '/home/cltbld', 10:53:13 INFO - 'LANG': 'en_US.UTF-8', 10:53:13 INFO - 'LANGUAGE': 'en_US:en', 10:53:13 INFO - 'LOGNAME': 'cltbld', 10:53:13 INFO - 'MAIL': '/var/mail/cltbld', 10:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:13 INFO - 'MOZ_NO_REMOTE': '1', 10:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:13 INFO - 'NO_EM_RESTART': '1', 10:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:13 INFO - 'PWD': '/builds/slave/test', 10:53:13 INFO - 'SHELL': '/bin/bash', 10:53:13 INFO - 'SHLVL': '1', 10:53:13 INFO - 'TERM': 'linux', 10:53:13 INFO - 'TMOUT': '86400', 10:53:13 INFO - 'USER': 'cltbld', 10:53:13 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:13 INFO - '_': '/tools/buildbot/bin/python'} 10:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:53:15 INFO - Installing collected packages: mozsystemmonitor 10:53:15 INFO - Running setup.py install for mozsystemmonitor 10:53:15 INFO - Successfully installed mozsystemmonitor 10:53:15 INFO - Cleaning up... 10:53:15 INFO - Return code: 0 10:53:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:15 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:15 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 10:53:15 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 10:53:15 INFO - Using env: {'DISPLAY': ':0', 10:53:15 INFO - 'HOME': '/home/cltbld', 10:53:15 INFO - 'LANG': 'en_US.UTF-8', 10:53:15 INFO - 'LANGUAGE': 'en_US:en', 10:53:15 INFO - 'LOGNAME': 'cltbld', 10:53:15 INFO - 'MAIL': '/var/mail/cltbld', 10:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:15 INFO - 'MOZ_NO_REMOTE': '1', 10:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:15 INFO - 'NO_EM_RESTART': '1', 10:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:15 INFO - 'PWD': '/builds/slave/test', 10:53:15 INFO - 'SHELL': '/bin/bash', 10:53:15 INFO - 'SHLVL': '1', 10:53:15 INFO - 'TERM': 'linux', 10:53:15 INFO - 'TMOUT': '86400', 10:53:15 INFO - 'USER': 'cltbld', 10:53:15 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:15 INFO - '_': '/tools/buildbot/bin/python'} 10:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:15 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 10:53:15 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 10:53:15 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 10:53:15 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 10:53:15 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 10:53:15 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 10:53:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 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 10:53:17 INFO - Downloading docopt-0.6.1.tar.gz 10:53:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:18 INFO - Running setup.py install for blobuploader 10:53:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:18 INFO - Running setup.py install for requests 10:53:18 INFO - Running setup.py install for docopt 10:53:18 INFO - Successfully installed blobuploader requests docopt 10:53:18 INFO - Cleaning up... 10:53:18 INFO - Return code: 0 10:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:18 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:18 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 10:53:18 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 10:53:18 INFO - Using env: {'DISPLAY': ':0', 10:53:18 INFO - 'HOME': '/home/cltbld', 10:53:18 INFO - 'LANG': 'en_US.UTF-8', 10:53:18 INFO - 'LANGUAGE': 'en_US:en', 10:53:18 INFO - 'LOGNAME': 'cltbld', 10:53:18 INFO - 'MAIL': '/var/mail/cltbld', 10:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:18 INFO - 'MOZ_NO_REMOTE': '1', 10:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:18 INFO - 'NO_EM_RESTART': '1', 10:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:18 INFO - 'PWD': '/builds/slave/test', 10:53:18 INFO - 'SHELL': '/bin/bash', 10:53:18 INFO - 'SHLVL': '1', 10:53:18 INFO - 'TERM': 'linux', 10:53:18 INFO - 'TMOUT': '86400', 10:53:18 INFO - 'USER': 'cltbld', 10:53:18 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:18 INFO - '_': '/tools/buildbot/bin/python'} 10:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:18 INFO - Running setup.py (path:/tmp/pip-JSMFSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:18 INFO - Running setup.py (path:/tmp/pip-lz0cdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:19 INFO - Running setup.py (path:/tmp/pip-bY2f16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:19 INFO - Running setup.py (path:/tmp/pip-RhlaVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:19 INFO - Running setup.py (path:/tmp/pip-hIfZ5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:19 INFO - Running setup.py (path:/tmp/pip-M0xMl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:19 INFO - Running setup.py (path:/tmp/pip-2tL3M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:19 INFO - Running setup.py (path:/tmp/pip-K5KZY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:19 INFO - Running setup.py (path:/tmp/pip-MBg4Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:19 INFO - Running setup.py (path:/tmp/pip-ciPPVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:19 INFO - Running setup.py (path:/tmp/pip-Vctu6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:19 INFO - Running setup.py (path:/tmp/pip-frK2Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:19 INFO - Running setup.py (path:/tmp/pip-Gcnb5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:19 INFO - Running setup.py (path:/tmp/pip-pnq6DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:19 INFO - Running setup.py (path:/tmp/pip-JD7DYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:19 INFO - Running setup.py (path:/tmp/pip-ZrUadg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:20 INFO - Running setup.py (path:/tmp/pip-_MeNU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:20 INFO - Running setup.py install for manifestparser 10:53:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Running setup.py install for mozcrash 10:53:20 INFO - Running setup.py install for mozdebug 10:53:20 INFO - Running setup.py install for mozdevice 10:53:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Running setup.py install for mozfile 10:53:20 INFO - Running setup.py install for mozhttpd 10:53:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Running setup.py install for mozinfo 10:53:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Running setup.py install for mozInstall 10:53:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:20 INFO - Running setup.py install for mozleak 10:53:20 INFO - Running setup.py install for mozlog 10:53:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Running setup.py install for moznetwork 10:53:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Running setup.py install for mozprocess 10:53:21 INFO - Running setup.py install for mozprofile 10:53:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Running setup.py install for mozrunner 10:53:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Running setup.py install for mozscreenshot 10:53:21 INFO - Running setup.py install for moztest 10:53:21 INFO - Running setup.py install for mozversion 10:53:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:21 INFO - Cleaning up... 10:53:21 INFO - Return code: 0 10:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:21 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:21 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 10:53:21 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 10:53:21 INFO - Using env: {'DISPLAY': ':0', 10:53:21 INFO - 'HOME': '/home/cltbld', 10:53:21 INFO - 'LANG': 'en_US.UTF-8', 10:53:21 INFO - 'LANGUAGE': 'en_US:en', 10:53:21 INFO - 'LOGNAME': 'cltbld', 10:53:21 INFO - 'MAIL': '/var/mail/cltbld', 10:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:21 INFO - 'MOZ_NO_REMOTE': '1', 10:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:21 INFO - 'NO_EM_RESTART': '1', 10:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:21 INFO - 'PWD': '/builds/slave/test', 10:53:21 INFO - 'SHELL': '/bin/bash', 10:53:21 INFO - 'SHLVL': '1', 10:53:21 INFO - 'TERM': 'linux', 10:53:21 INFO - 'TMOUT': '86400', 10:53:21 INFO - 'USER': 'cltbld', 10:53:21 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:21 INFO - '_': '/tools/buildbot/bin/python'} 10:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:22 INFO - Running setup.py (path:/tmp/pip-LxGVWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:22 INFO - Running setup.py (path:/tmp/pip-pc4Hhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:22 INFO - Running setup.py (path:/tmp/pip-D48jWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:22 INFO - Running setup.py (path:/tmp/pip-211Yuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:22 INFO - Running setup.py (path:/tmp/pip-WhFknX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:22 INFO - Running setup.py (path:/tmp/pip-hB7Adf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:22 INFO - Running setup.py (path:/tmp/pip-CrLkus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:22 INFO - Running setup.py (path:/tmp/pip-_P1Ou3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:22 INFO - Running setup.py (path:/tmp/pip-1fT_il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:22 INFO - Running setup.py (path:/tmp/pip-zy5n3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:22 INFO - Running setup.py (path:/tmp/pip-Iq6FdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:22 INFO - Running setup.py (path:/tmp/pip-DaacIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:22 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)) 10:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:22 INFO - Running setup.py (path:/tmp/pip-rbXpU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:23 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)) 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:23 INFO - Running setup.py (path:/tmp/pip-uJCcvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:23 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)) 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:23 INFO - Running setup.py (path:/tmp/pip-CHslUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:23 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)) 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:23 INFO - Running setup.py (path:/tmp/pip-gt1nji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:23 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)) 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:23 INFO - Running setup.py (path:/tmp/pip-ji_aRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:23 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)) 10:53:23 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)) 10:53:23 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)) 10:53:23 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)) 10:53:23 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)) 10:53:23 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)) 10:53:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:24 INFO - Downloading blessings-1.5.1.tar.gz 10:53:24 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 10:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:25 INFO - Installing collected packages: blessings 10:53:25 INFO - Running setup.py install for blessings 10:53:25 INFO - Successfully installed blessings 10:53:25 INFO - Cleaning up... 10:53:25 INFO - Return code: 0 10:53:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:25 INFO - Reading from file tmpfile_stdout 10:53:25 INFO - Current package versions: 10:53:25 INFO - argparse == 1.2.1 10:53:25 INFO - blessings == 1.5.1 10:53:25 INFO - blobuploader == 1.2.4 10:53:25 INFO - docopt == 0.6.1 10:53:25 INFO - manifestparser == 1.1 10:53:25 INFO - mozInstall == 1.12 10:53:25 INFO - mozcrash == 0.16 10:53:25 INFO - mozdebug == 0.1 10:53:25 INFO - mozdevice == 0.47 10:53:25 INFO - mozfile == 1.2 10:53:25 INFO - mozhttpd == 0.7 10:53:25 INFO - mozinfo == 0.9 10:53:25 INFO - mozleak == 0.1 10:53:25 INFO - mozlog == 3.1 10:53:25 INFO - moznetwork == 0.27 10:53:25 INFO - mozprocess == 0.22 10:53:25 INFO - mozprofile == 0.27 10:53:25 INFO - mozrunner == 6.11 10:53:25 INFO - mozscreenshot == 0.1 10:53:25 INFO - mozsystemmonitor == 0.0 10:53:25 INFO - moztest == 0.7 10:53:25 INFO - mozversion == 1.4 10:53:25 INFO - psutil == 3.1.1 10:53:25 INFO - requests == 1.2.3 10:53:25 INFO - wsgiref == 0.1.2 10:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:25 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:25 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 10:53:25 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 10:53:25 INFO - Using env: {'DISPLAY': ':0', 10:53:25 INFO - 'HOME': '/home/cltbld', 10:53:25 INFO - 'LANG': 'en_US.UTF-8', 10:53:25 INFO - 'LANGUAGE': 'en_US:en', 10:53:25 INFO - 'LOGNAME': 'cltbld', 10:53:25 INFO - 'MAIL': '/var/mail/cltbld', 10:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:25 INFO - 'MOZ_NO_REMOTE': '1', 10:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:25 INFO - 'NO_EM_RESTART': '1', 10:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:25 INFO - 'PWD': '/builds/slave/test', 10:53:25 INFO - 'SHELL': '/bin/bash', 10:53:25 INFO - 'SHLVL': '1', 10:53:25 INFO - 'TERM': 'linux', 10:53:25 INFO - 'TMOUT': '86400', 10:53:25 INFO - 'USER': 'cltbld', 10:53:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:25 INFO - '_': '/tools/buildbot/bin/python'} 10:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 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)) 10:53:25 INFO - Cleaning up... 10:53:25 INFO - Return code: 0 10:53:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:25 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:25 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 10:53:25 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 10:53:25 INFO - Using env: {'DISPLAY': ':0', 10:53:25 INFO - 'HOME': '/home/cltbld', 10:53:25 INFO - 'LANG': 'en_US.UTF-8', 10:53:25 INFO - 'LANGUAGE': 'en_US:en', 10:53:25 INFO - 'LOGNAME': 'cltbld', 10:53:25 INFO - 'MAIL': '/var/mail/cltbld', 10:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:25 INFO - 'MOZ_NO_REMOTE': '1', 10:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:25 INFO - 'NO_EM_RESTART': '1', 10:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:25 INFO - 'PWD': '/builds/slave/test', 10:53:25 INFO - 'SHELL': '/bin/bash', 10:53:25 INFO - 'SHLVL': '1', 10:53:25 INFO - 'TERM': 'linux', 10:53:25 INFO - 'TMOUT': '86400', 10:53:25 INFO - 'USER': 'cltbld', 10:53:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:25 INFO - '_': '/tools/buildbot/bin/python'} 10:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:25 INFO - Downloading/unpacking jsonschema 10:53:25 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 10:53:25 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 10:53:25 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 10:53:25 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 10:53:25 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 10:53:25 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 10:53:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:27 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 10:53:27 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:27 INFO - warning: no files found matching '*.txt' 10:53:27 INFO - no previously-included directories found matching 'build' 10:53:27 INFO - no previously-included directories found matching 'dist' 10:53:27 INFO - no previously-included directories found matching '.git*' 10:53:27 INFO - Installing collected packages: jsonschema, functools32 10:53:27 INFO - Running setup.py install for functools32 10:53:27 INFO - warning: no files found matching '*.txt' 10:53:27 INFO - no previously-included directories found matching 'build' 10:53:27 INFO - no previously-included directories found matching 'dist' 10:53:27 INFO - no previously-included directories found matching '.git*' 10:53:27 INFO - Successfully installed jsonschema functools32 10:53:27 INFO - Cleaning up... 10:53:28 INFO - Return code: 0 10:53:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:28 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 0x7fed4a01bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', '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 10:53:28 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 10:53:28 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 10:53:28 INFO - Using env: {'DISPLAY': ':0', 10:53:28 INFO - 'HOME': '/home/cltbld', 10:53:28 INFO - 'LANG': 'en_US.UTF-8', 10:53:28 INFO - 'LANGUAGE': 'en_US:en', 10:53:28 INFO - 'LOGNAME': 'cltbld', 10:53:28 INFO - 'MAIL': '/var/mail/cltbld', 10:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:28 INFO - 'MOZ_NO_REMOTE': '1', 10:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:28 INFO - 'NO_EM_RESTART': '1', 10:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:28 INFO - 'PWD': '/builds/slave/test', 10:53:28 INFO - 'SHELL': '/bin/bash', 10:53:28 INFO - 'SHLVL': '1', 10:53:28 INFO - 'TERM': 'linux', 10:53:28 INFO - 'TMOUT': '86400', 10:53:28 INFO - 'USER': 'cltbld', 10:53:28 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:28 INFO - '_': '/tools/buildbot/bin/python'} 10:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:28 INFO - Downloading/unpacking flake8 10:53:28 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 10:53:28 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 10:53:28 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 10:53:28 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 10:53:28 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 10:53:28 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 10:53:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:29 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 10:53:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:30 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 10:53:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 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 10:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:30 INFO - no previously-included directories found matching 'docs/_build' 10:53:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:30 INFO - Running setup.py install for pep8 10:53:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:30 INFO - no previously-included directories found matching 'docs/_build' 10:53:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:30 INFO - Cleaning up... 10:53:30 INFO - Return code: 0 10:53:30 INFO - Running post-action listener: _resource_record_post_action 10:53:30 INFO - Running post-action listener: _start_resource_monitoring 10:53:30 INFO - Starting resource monitoring. 10:53:30 INFO - ##### 10:53:30 INFO - ##### Running install step. 10:53:30 INFO - ##### 10:53:30 INFO - Running pre-action listener: _resource_record_pre_action 10:53:30 INFO - Running main action method: install 10:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:31 INFO - Reading from file tmpfile_stdout 10:53:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:31 INFO - Reading from file tmpfile_stdout 10:53:31 INFO - Output received: 10:53:31 INFO - Usage: mozinstall [options] installer 10:53:31 INFO - Options: 10:53:31 INFO - -h, --help show this help message and exit 10:53:31 INFO - -d DEST, --destination=DEST 10:53:31 INFO - Directory to install application into. [default: 10:53:31 INFO - "/builds/slave/test"] 10:53:31 INFO - --app=APP Application being installed. [default: firefox] 10:53:31 INFO - mkdir: /builds/slave/test/build/application 10:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:53:45 INFO - Reading from file tmpfile_stdout 10:53:45 INFO - Output received: 10:53:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:45 INFO - Running post-action listener: _resource_record_post_action 10:53:45 INFO - ##### 10:53:45 INFO - ##### Running run-tests step. 10:53:45 INFO - ##### 10:53:45 INFO - Running pre-action listener: _resource_record_pre_action 10:53:45 INFO - Running main action method: run_tests 10:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:45 INFO - Python 2.7.3 10:53:45 INFO - Return code: 0 10:53:45 INFO - grabbing minidump binary from tooltool 10:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:45 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 0x25500b0>, '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 0x2550fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:45 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 10:53:45 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 10:53:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:45 INFO - Return code: 0 10:53:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:46 INFO - Return code: 0 10:53:46 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/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test/build 10:53:46 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/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 10:53:46 INFO - Using env: {'DISPLAY': ':0', 10:53:46 INFO - 'HOME': '/home/cltbld', 10:53:46 INFO - 'LANG': 'en_US.UTF-8', 10:53:46 INFO - 'LANGUAGE': 'en_US:en', 10:53:46 INFO - 'LOGNAME': 'cltbld', 10:53:46 INFO - 'MAIL': '/var/mail/cltbld', 10:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:46 INFO - 'MOZ_NO_REMOTE': '1', 10:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:46 INFO - 'NO_EM_RESTART': '1', 10:53:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:46 INFO - 'PWD': '/builds/slave/test', 10:53:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:46 INFO - 'SHELL': '/bin/bash', 10:53:46 INFO - 'SHLVL': '1', 10:53:46 INFO - 'TERM': 'linux', 10:53:46 INFO - 'TMOUT': '86400', 10:53:46 INFO - 'USER': 'cltbld', 10:53:46 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649', 10:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:46 INFO - '_': '/tools/buildbot/bin/python'} 10:53:46 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/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 10:53:46 INFO - mozversion INFO | application_buildid: 20151216101638 10:53:46 INFO - mozversion INFO | application_changeset: 7489db357bd48b2bd1751b474c3a91cfa55a9420 10:53:46 INFO - mozversion INFO | application_display_name: Nightly 10:53:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:46 INFO - mozversion INFO | application_name: Firefox 10:53:46 INFO - mozversion INFO | application_remotingname: firefox 10:53:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:53:46 INFO - mozversion INFO | application_vendor: Mozilla 10:53:46 INFO - mozversion INFO | application_version: 46.0a1 10:53:46 INFO - mozversion INFO | platform_buildid: 20151216101638 10:53:46 INFO - mozversion INFO | platform_changeset: 7489db357bd48b2bd1751b474c3a91cfa55a9420 10:53:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:46 INFO - mozversion INFO | platform_version: 46.0a1 10:53:46 INFO - 2015-12-16 10:53:46,846 DEBUG : using testdate: 1450292026 10:53:46 INFO - 2015-12-16 10:53:46,846 DEBUG : actual date: 1450292026 10:53:46 INFO - 2015-12-16 10:53:46,893 INFO : starting webserver on 'localhost:47070' 10:53:46 INFO - 2015-12-16 10:53:46,894 INFO : Starting test suite talos-linux64-ix-057 10:53:46 INFO - 2015-12-16 10:53:46,894 INFO : Starting test dromaeo_css 10:53:46 INFO - 2015-12-16 10:53:46,894 DEBUG : operating with platform_type : linux_ 10:53:46 INFO - 2015-12-16 10:53:46,895 INFO : Initialising browser for dromaeo_css test... 10:53:46 INFO - 2015-12-16 10:53:46,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdMGHm/profile http://localhost:47070/getInfo.html 10:53:51 INFO - 2015-12-16 10:53:51,357 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:53:51 INFO - 2015-12-16 10:53:51,357 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:53:51 INFO - 2015-12-16 10:53:51,357 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:53:51 INFO - 2015-12-16 10:53:51,357 DEBUG : BROWSER_OUTPUT: __metrics 10:53:51 INFO - 2015-12-16 10:53:51,454 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] 10:53:51 INFO - 2015-12-16 10:53:51,514 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] 10:53:51 ERROR - 2015-12-16 10:53:51,530 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:53:51 INFO - 2015-12-16 10:53:51,788 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:53:52 INFO - 2015-12-16 10:53:52,478 INFO : Browser initialized. 10:53:52 INFO - 2015-12-16 10:53:52,478 INFO : Running cycle 1/1 for dromaeo_css test... 10:53:52 INFO - 2015-12-16 10:53:52,478 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdMGHm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:54:04 INFO - 2015-12-16 10:54:04,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 140193792 10:54:04 INFO - 2015-12-16 10:54:04,472 DEBUG : BROWSER_OUTPUT: 10:54:55 INFO - 2015-12-16 10:54:55,720 DEBUG : BROWSER_OUTPUT: 1450292095720 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] 10:57:07 INFO - 2015-12-16 10:57:07,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47070/tests/dromaeo/cssquery-ext.html) 10:57:08 INFO - 2015-12-16 10:57:08,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 261173248 10:57:08 INFO - 2015-12-16 10:57:08,860 DEBUG : BROWSER_OUTPUT: 11:00:11 INFO - 2015-12-16 11:00:11,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-ext.html (next: http://localhost:47070/tests/dromaeo/cssquery-jquery.html) 11:00:12 INFO - 2015-12-16 11:00:12,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 225849344 11:00:12 INFO - 2015-12-16 11:00:12,006 DEBUG : BROWSER_OUTPUT: 11:03:14 INFO - 2015-12-16 11:03:14,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47070/tests/dromaeo/cssquery-mootools.html) 11:03:14 INFO - 2015-12-16 11:03:14,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 226381824 11:03:14 INFO - 2015-12-16 11:03:14,611 DEBUG : BROWSER_OUTPUT: 11:06:16 INFO - 2015-12-16 11:06:16,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47070/tests/dromaeo/cssquery-prototype.html) 11:06:17 INFO - 2015-12-16 11:06:17,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 206336000 11:06:17 INFO - 2015-12-16 11:06:17,204 DEBUG : BROWSER_OUTPUT: 11:09:20 INFO - 2015-12-16 11:09:20,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47070/tests/dromaeo/cssquery-yui.html) 11:09:20 INFO - 2015-12-16 11:09:20,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 183803904 11:09:20 INFO - 2015-12-16 11:09:20,660 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/dromaeo/cssquery-yui.html (next: http://localhost:47070/tests/dromaeo/cssquery-dojo.html) 11:12:23 INFO - 2015-12-16 11:12:23,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 255496192 11:12:23 INFO - 2015-12-16 11:12:23,468 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:12:23 INFO - 2015-12-16 11:12:23,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:12:23 INFO - 2015-12-16 11:12:23,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:12:23 INFO - 2015-12-16 11:12:23,468 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:12:23 INFO - 2015-12-16 11:12:23,469 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.659054322938;2701.5812549054904;2710.7018227994918;2712.55242884924;2731.740484653958;4475.731456112636;4569.291759777231;4655.138799322123;4713.552212539807;4730.787114579844;4554.362389265505;4596.81612735491;4698.600618947385;4698.90602187956;4745.050989802036;4304.591063848945;4349.021470169202;4352.325389564615;4355.36847157162;4367.781610919457;4213.5786421357925;4445.866624001285;4450.532694067125;4504.481984571784;4507.188706032913;4289.528151903288;4352.39066530686;4358.978205108986;4365.43249377582;4396.406485124499;4364.323529852878;4371.781410929472;4386.539413361583;4403;4446.533114023014;4163.167366526676;4280.507741609724;4360.040791026001;4380.496242932039;4436.0906014267;4508.729476231437;4552;4590.127875703605;4626.791794369262;4631.58315751584;5051.621128415383;5052.671576347562;5067.163917953533;5072.695638261716;5109.131447653871;4874.512548745132;5099.36257967754;5101;5103.464136265676;5105;4644.396228490308;4644.651651126179;4662.090892276007;4723.5984941279685;4773.236282194902;5187.144121219956;5222.086134926372;5229.294045303835;5230.424653288135;5233.1365324721755;4887.193613053806;5009.173486374781;5029.673071250357;5032.3961124665275;5072.898542029138;4999.700017998932;5009.298698182258;5012.523810238022;5069.518395752398;5086.491350864958;5000.1249781288125;5010.248462730547;5013.674111182761;5014.122528557488;5052.646314758005;4775.140474714515;4970.204767237225;4975.378077740283;4978.178600530872;5023.6985780853265;4108.630223279919;4140.192662430857;4151.46031015972;4163.333866581333;4174.415581818548;3679.466477360768;3680.2639472105684;3681.5029970954115;3699.352613292663;3714.201446688975;4160.895977600584;4361.629261512807;4371.803268852909;4390.692651514363;4401.515833258339;4836.129496690559;4911.091448082117;4915.754212289371;4986.501349864984;5035.043341765127;4286.592773686495;4320.092780516064;4335.219660461147;4335.4363932689175;4378.956210437918;4262.211490874198;4454.888627784331;4455.086707225011;4455.844045458393;4487.214737420938;4677.7193368398;4697.95302046982;4716.033213191287;4736.976315118402;4788.305695674038;5018.04657115147;5064.645474816727;5065.417476990193;5068.949310506995;5110.97444512775;4655.604273636779;4803.039392121659;4814.037192561432;4818.10864989978;4855.028994201244;4899.265110233494;4933.654644174873;4941.110600092018;4954.900901982012;5014.9498505015945;5001.449840517467;5048.0156369507595;5061.822836200715;5068.341115654941;5112.105381558138;4588.701734387254;4824.300476430968;4865.318855360181;4869.70781753096;4918.950810491992;4712.976435117803;4774.997250577418;4794.952050479451;4814.9518504814505;4816.301636262792;4786.425628924551;4798.3042458843975;4799.400074990626;4818.229083346648;4842.491538388418;4697.8355757548325;4921.409430868319;4927.556519913225;4934.753262336797;4966.528179822911;4683.367745354333;4755.38180036593;4784.808607655655;4835.081334546425;4880.926786098283 11:12:23 INFO - 2015-12-16 11:12:23,469 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.4732372555386;573.1917995626167;577.5552824325267;578.9971050144749;599.7121381736766;26768;35100.297994040106;35852.103697407576;35980.640193598054;36003.639963600355;38746.8062659687;39008.60991390085;39071.804640976756;39072.80463597685;39090.41364379529;7044;7166.283371662844;7876.763697089096;8043.03483581971;8049.6377663005305;10052.49737513125;10330.121939635103;10332.845007324897;10333.896661033406;10345.379277243352;9603.4718090505;9732.65935692251;9738.26962977776;9739.56171972263;9740.610375584969;10019.749506262366;10068.496575171212;10120.544575494121;10142;10146.594136234542;9767.462789546573;9887.159591434665;9936.95031524845;9937.75155621108;9946.104850563412;37374.43938340927;37628.62371376306;37795.244095117945;37831.432528512094;37865;3020.8338541380217;3056.190109620952;3571.964280357189;3601.7478776485655;3647.6170002149656;27979.155643849044;28301.025320350425;28432.751550210964;28546.714532854614;29093.563596546068;3258.804471731704;3275.7215636670912;3281.835908204604;3415.26571787067;3437.157896315419;212892;213230;213612;214283.9285803561;214625.9268703662;50346;51559.226611600854;52965.70342965673;52980.47019529832;53226.7338663312;62323;62825;63007;63150.68424657939;63226.36773632205;14400.135991840523;14638;14649.487267945784;14658.853411465961;14661.706765864623;10086.949565252127;10087.798244035079;10412.062914337594;11169.664910052712;11257.887421125848;17795.46613601594;18003;18136.365227216986;18174.09129543544;18213.08934553267;6821.69302381394;7061.611611361322;7066.92933070673;7138.428925686037;7221.89167162493;815.8327542853701;892.9464232146092;901.5176880368971;1016.5781200801732;1072.1797824664138;25955.610665840028;27106.728932710816;27314.863425683143;27557.862210689218;27571.86214068957;951.4196340232453;991.2317953586029;1044.300318786415;1078.7788503356794;1081.3944191252924;12823.139620303093;12873.420696068699;12876.163049401759;13363.198208107544;13411.262380568967;254913;258310;258767;259551;259899;45165.322520162226;45521.85454963604;45542.54457455449;45576.772116139204;45719.88521033056;1246.0965799795258;1258.9937050314873;1265.0385706862667;1268.8731126887237;1272.3002348708173;24642.137525186532;25400;25983.870080649474;26032.219033429028;26069.869650651624;39357.606423935395;39367.606323937536;39465.40801887916;39814.80092599519;39893.800530997156;245753;247901;247959;248452;248831;24343.269701908972;28427;28651.42697146087;28909;29102.5448727567;32909.34181316408;38642;39284.410733839584;39855.60144398635;39883.2023359537;29409.705902940696;29494.852525737235;29563.26091847721;29753;32565.18587035343;25696.486070278865;28988.85505572543;30873.382532349675;31813;33415.1646208837;29689.554656679735;30021.84989075128;30192.09423717292;30471.238219044702;30485.847570762005;26978;27182.864085680238;28014.96195021324;29608.259793505335;29632.703672962994;22821.88589057044;23182.76817231806;23341.41646458852;23386.18148364799;23469.178578749663 11:12:23 INFO - 2015-12-16 11:12:23,469 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.1448689945443;325.8077734136859;329.40049110618673;338.4564994069566;340.1496259351621;12288.385580720973;12586.81119783204;15683.607909802246;16188.65455780343;16969.575760605974;13022.413991370388;15643.296051677673;15735.291911863966;15746.291416886239;15926;4830.758462076899;4833.9516604834025;4968.130577148984;4975.950240497603;4989.151844186497;3637.4543818427182;3766.642168993941;3776.339140650389;3814.5994670559608;4932.926006109911;3782.8865134046023;3796.468494410785;5573.470520300585;5743.081107022877;5745.6552606843725;5220.843374698765;5724.398938111501;5752.856178595548;5765.077587586008;5776.249087618625;5068.366454193226;5079.847604571832;5081.085404627165;5085.313482679865;5089.3638295213095;18979.145938432805;19236;19385.51536211592;19604.50988725279;19662.11520481582;1837.4671345309844;1942.5726340205133;1957.745493085904;2014.2547257514666;2037.572109856917;12375.75248495034;12393.442295096653;12460.81308780369;12644.747105057848;12693.301868397235;1649.934002639893;1781.2251670523235;1787.0885848217372;1787.6235298819965;1797.8741488095839;52866;54012.18981715277;54111.458885411426;54623.18065229025;55306.446935530534;9253.861192082124;9370.95314523423;9429.48137852411;9453.480058596706;9544.904550954541;11703.654079780934;11705.707357316136;11707.180497365103;11752.294862308117;11757.118216133824;7301.2333704961275;7361.116666000007;7397.667104980289;7430.851382972419;7442.553446793209;7206.675699593531;7237.312455316736;7251.8187045324285;7268.0914885639295;7282.417406607458;5519.806806761744;5559.694216818033;5569.832905012856;5696.3449203341315;5715.771369145271;1583.6832633473352;1636.869050475959;1639.9262033208533;1660.867130629571;1722.0786879019665;862.7109918177356;917.7476194046691;965.2471072563412;982.3958265666564;1040.7138037039724;15916.389093882679;16322.102284374236;16402;16439.67120657604;16555.586110347096;777.2072486064296;885.4908427654125;915.8259930613162;933.453929451265;958.7171784323641;9030.954845225731;9232.95383523078;9421.952890235505;9508.714738557854;9527.904720952702;458863;469835;480161;480840;483047;70488.2951170492;72367.63816180885;73177.26822731705;73307.63346183342;73468.63265683637;1075.4461452352045;1098.4837126550508;1098.906592939593;1103.900648941599;1126.0934947367448;14713.190774507504;15003.474878379204;15178.392864285304;15186.164760938254;15394.923025384802;33195;33214.66785332116;33604.15989600182;34572.82713586416;34653;44140.33789493096;45663.31505027361;46301.536984629725;46412.30381544347;46952.98637653708;8146.266835984789;8352.874706879524;8357.874631880404;8411.53736544496;8455.450395724258;9712.417254964725;15289.311980960661;15573.766393504333;16114.113723745306;16173.272202751139;13264.867351326364;13295.66760830987;13659.86340136586;13660.93169534146;13861.237631929936;13499.460021599027;13509.932450337685;13750.587482375544;13787.586372408843;14127;13633.727325453634;13735.587932362045;13890;14504.202268875313;14558.27208639585;8373.66505339804;8430.072692003752;8439.029511606244;8452.661893524437;8560.571971401281;9436.103570160823;12225.20536165182;13207.867921320663;13386.330683465592;14243.35904884262 11:12:23 INFO - 2015-12-16 11:12:23,470 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1421.3106643278015;1609.5493261886672;1667.6581300833327;1700.124435915503;1743.7471566622849;6142.508599312056;7077.150741910971;7284.745033923814;7287.27127287271;7289.635518224094;6916.58500489971;7110.395616372602;7112.253213412595;7113.5376200546925;7124.572525648465;1753.132199561219;1783.652187823375;1785.1342099082;2102.4743814046487;2140.2616097446357;1806.7380229866726;2057.6090542796896;2085.3326935380683;2090.289301637443;2092.3932059702743;2057.495913501187;2062.443140352104;2073.5749171419898;2074.3776866939934;2081.344376521391;2085.9165633374646;2095.298075144821;2107.1150116950917;2108.4307237045987;2113.450502869265;2090.3937858021154;2092.058573641867;2116.280464642029;2118.385668156233;2128.074287684862;7158.141023077264;7216.278372162794;7217.494775365726;7221;7235.023271858285;4165.687573432005;4244.766537840417;4247.27796274631;4254.489461264668;4255;2697.2178068360154;2706.91879243623;2772.625695531118;2786.6934637190097;2799.664040315155;828.2711214131525;843.7848348671049;859.879616853641;866.0992567729554;871.9782005449852;9738.561764720534;9742.415455072647;9743;9750.366226195345;9754.170895473893;3924.489816323917;3998.900027499336;4002.139539998914;4008.9799551002056;4081.2449696806184;8342.124076971952;8346.415750897379;8348.206920342558;8364.790880227922;8371.665133394717;4328.09110086879;4331.631811296075;4341.45731783527;4353.934690979638;4367.519572846984;3906.68746500285;3924.7841368724994;3929.6070392960473;3934.822932967966;3935.6064393560987;3013.186439661323;3075.815451072943;3331.383694016566;3405.2848901730417;3405.9318813624086;1073.1897417449932;1092.5138313450598;1096.4298564746287;1105.1876870500175;1120.467777805552;934.5654270764128;935.8596210568469;960.3901522533102;992.161623428202;1121.388843080523;6797.796066117926;6833.658317084126;6872.828179295458;6883.759068432681;6883.827904302432;1029.0812200120004;1052.0636633396284;1060.4909643371225;1072.0512346573182;1088.3361149698678;5255.421903590602;5367.677939323653;5373.731313434313;5384.703841288767;5391.973040134774;8249;8374.832503349899;8376.664933402717;8441.198086181803;8479;8257.710980115788;8283;8314.916850831536;8373.95813020931;8386.748397548083;6770.763023294161;6824.590524568542;6881.552699074544;6915.654217289115;6930.410915072275;6749.257581666111;6783.253842077269;6803.183617965876;6809.353111454404;6887.552309099892;7509.812254693677;7734.845303093794;7781.610919454118;7838.568878711726;7841.4118941078505;7778.572178530235;7885.408594355561;7934.523928564305;7943.364530837403;8061.072976607765;6500.577462464925;6529;6557.508186885907;6578.7368505261165;6601.768938087144;5815.447532484407;5922.2597175353085;6627.867442651216;6851.657417129223;6907.033015377951;6530.967345163243;6537.411632953057;6632.767853125118;6637.601743895381;6673.165854268216;6417.358264173546;6429.132067170872;6493.545451818516;6569.638669873203;6580.1116849224745;6023.156758053964;6341.746330146742;6349.8730025400155;6351.428371446592;6367.108604795239;6110.938890611214;6124.663143527148;6136.386361364007;6136.417040381157;6141.109539116714;5998.940010599838;6052.909206361996;6086.604370716066;6090.573659843769;6110.969445152746 11:12:23 INFO - 2015-12-16 11:12:23,470 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.49871466578804;299.1906891857527;304.6983486348515;310.88652641785745;310.973567246784;5301.151815709487;5325.653832500885;5384.8115315964;5394.811181608645;5407.134858422653;5272.710000949946;5299.33758280215;5300.602454815885;5307.177387504943;5331.840044798662;3941.507311586052;4105.97947010266;4113.341865301552;4121.443605113316;4122.340425531908;4046.6155715207155;4057.8376864925367;4160.209560183571;4191.098913733546;4195.601417865298;4134.3178375567995;4140.358244472111;4151.045259590296;4151.066010147722;4151.813168407414;3893.357595996657;3973.0663294125857;4008.2584721826265;4137.1725654869;4152.1280531088505;3667.889963301105;3669.412893936957;3673.4673472346626;3676.5588129424373;3680.576733675635;5068.087744206042;5079.339685840854;5085.8728531787;5089.796408143669;5092.3125378073855;4749.382580264578;4752.215884379108;4754.904901901942;4759.23852183649;4761.0715910397485;5420.647657902263;5561.165825126223;5569.498745112919;5579.688773138309;5583.274174357348;3983.183447393277;3983.900402489932;3984.6613037891525;3986.80065996699;3994.6404823566018;5862.560307976919;5868.794592189253;5869.148973398876;5869.853253668693;5880.705964701748;4100.36444351126;4102.097538541516;4104.671626269891;4105.856295029719;4106.835726570904;3718.665320121148;3869.709771767072;4171.374293855946;4172.102997855475;4172.520160181557;4504.572065653758;4517.81928722854;4578.175928332932;4614.123316569841;4699.929501057487;5513.862153446196;5521.282233309725;5582.581306402036;5584.804531841366;5592.7762889483965;1392.6657602175405;1424.0743516714012;1424.2522675595396;1424.64383904024;1429.0425414971994;965.0879918476971;969.888462826784;970.4225985538593;986.5116767200138;988.2143695761742;4904.2643603459765;4923.532264434873;4925.408950925912;4930;4934.383202099738;5774.769009239667;5776.249087618583;5776.33572139201;5785.218995435646;5785.566082543826;4892.730899800546;4899.363082799213;4900.313956046157;4906.11689895815;4909.263610458388;3035.4839677254918;3085;3107.409592177479;3111.471049921519;3118.7037231462973;5504.889902201933;5562.249096372019;5562.554995600342;5562.694051827189;5568.638038527482;6013.548983826143;6018.398160183947;6019.097135429721;6021.036634138517;6022.18700475439;5544.1960915667805;5554.389017208104;5555.916661250085;5557.166425036277;5562.082256427644;5675.262215911905;5822.359540450631;5829.0090684584575;5832.533397328289;5834.241548598655;5679.261695979661;5699.829005129853;5700.515456186271;5701.7149142541875;5707.343655479673;5539.806106786243;5541.972290138524;5546.362168350692;5559.610827242054;5559.749811258584;3863.787491687872;3930.803459827054;3976.2047590481443;3977.6618987386396;3989.06257029592;5766.192733017297;5768.307803063659;5773.249477568057;5777.7977770777825;5782.624129431573;5523.171524271392;5524;5528.4471552846;5531.197976293495;5533.170024496197;5525.889482210414;5544.085225937675;5546.473085056913;5547.11246200606;5547.528460080777;5318.7340632967425;5487.368952570506;5487.890242195054;5490.945090549043;5492.505674489315;5360.490753378579;5546.306711661043;5632.239647647679;5638.4925356718095;5639.379668236573;5374.435684253097;5493.780248790164;5510.448955104457;5522.723863806874;5528.308961379827 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: |5;yui.html;754.9396048316133;759.1649185895516;762.5920132728991;764.3197554176784;765.1736124985017;11614.825777613332;11853.940730296337;11881.227720198192;11883.22759020663;11897.226680265798;10757.946210268958;11438.542458301657;11468.71328216795;11496.942515287412;11511.597094101688;640.7180840430219;648.6270394523144;804.1877703519458;815.7226542975387;832.8917240758693;800.0719165767711;806.9273765361116;807.1000834069999;811.5212024905304;821.4496287487398;842.5239739547167;842.8314337132598;843.3548335523329;846.2045677063571;859.9570021498931;666.2471407309757;668.812732434919;827.0860698927659;831.8128421105264;835.8119423129808;617.2438762515927;617.3425302053299;618.2519151826295;629.5624540944045;637.9298277189505;11106.44467776616;11402.030827379682;11404.315741055563;11405.771884562346;11417.543298268143;11205.271657342328;11567.76864462706;11713.765724685458;11793;11884.643460696107;9689.12797848197;9705.223582113415;9719.757006074835;9780.951095244478;10112.89887101127;3205.2307446212976;3240.238543942172;3240.5139229115584;3243.124356423776;3343.1307859956587;40440.19119617591;40757;40795.59204407947;40873.79563102195;40890;9278.371055148264;9422.811543769087;9533.570989305497;9548.713538593853;9593.616255349707;15575.766363504557;15788.763168552481;15789.526314210592;15793.526194214191;15832.76250856238;5831.7667293307795;5883.352831188566;5891.911621325684;6025.879482410327;6214.751409943552;3584.6594573515476;3619.8914032579064;3623.112337477335;3660.7254455915913;3673.246984368198;2546.5288921549572;2583.1733845169742;2587.0815860369676;2589.572720501134;2589.9870500647376;458.7362266696663;458.8371128249423;462.4750907719762;463.6406784741852;466.1004261774807;509.52868596548046;573.3635664412499;582.3826743651742;594.8007417515181;629.5247088448192;7909.446338756347;7950.801229969182;8239.258466738022;8730.519821409756;8756;399.920015996796;407.3604441027558;426.9778684789292;509.5781825044768;551.7461967494997;3577.6422357764013;3817.141143242748;3817.351050321452;3845.307844587945;3970.4242884781543;50637.240441393405;50890.49109508932;51123.74438127786;51167.48832511702;51267.23099153516;43797.12405751931;44447;44662.33006504905;44924;44927;39412.802935985135;39956.40065399021;39971.40042899359;40217.79891100584;40507.39238911419;7677.558520412346;7702.614869256627;7853.1361550228285;7867.763967080997;8015.47899386538;29233.85383073071;29587;29752.85123574368;29777;29791.55312670268;34986;36515.26969460649;38316;38465.61534384732;38845.417318739674;9271.305637539304;9284.350095493252;9419.576119074522;9439.244860411014;9456.763580910532;10233.334833235816;10402.739931501774;10429.11352535043;10436.582536698446;10499.845017047966;9856.753581160528;9932;9937.801243975224;9998.100170984646;10187.490625468548;9216.07839216073;9277;9460;9647.951760241154;9687.951560242154;9368.4378937264;9550.235981121356;9675.564599592895;9758.46328451942;9769.511524423893;8612.224899759052;8774.868376974478;8826.646934122564;8970.147835955573;9134.862977055482;8321.83356332882;8513.702020429255;8580.313574914117;8592.31261499066;8715.825683486422 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293143461__endTimestamp 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,472 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4635.86 Median:4745.05 stddev:481.94 (10.2%) stddev-sans-first:456.81 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: Values: 2622.7 2701.6 2710.7 2712.6 2731.7 4475.7 4569.3 4655.1 4713.6 4730.8 4554.4 4596.8 4698.6 4698.9 4745.1 4304.6 4349.0 4352.3 4355.4 4367.8 4213.6 4445.9 4450.5 4504.5 4507.2 4289.5 4352.4 4359.0 4365.4 4396.4 4364.3 4371.8 4386.5 4403.0 4446.5 4163.2 4280.5 4360.0 4380.5 4436.1 4508.7 4552.0 4590.1 4626.8 4631.6 5051.6 5052.7 5067.2 5072.7 5109.1 4874.5 5099.4 5101.0 5103.5 5105.0 4644.4 4644.7 4662.1 4723.6 4773.2 5187.1 5222.1 5229.3 5230.4 5233.1 4887.2 5009.2 5029.7 5032.4 5072.9 4999.7 5009.3 5012.5 5069.5 5086.5 5000.1 5010.2 5013.7 5014.1 5052.6 4775.1 4970.2 4975.4 4978.2 5023.7 4108.6 4140.2 4151.5 4163.3 4174.4 3679.5 3680.3 3681.5 3699.4 3714.2 4160.9 4361.6 4371.8 4390.7 4401.5 4836.1 4911.1 4915.8 4986.5 5035.0 4286.6 4320.1 4335.2 4335.4 4379.0 4262.2 4454.9 4455.1 4455.8 4487.2 4677.7 4698.0 4716.0 4737.0 4788.3 5018.0 5064.6 5065.4 5068.9 5111.0 4655.6 4803.0 4814.0 4818.1 4855.0 4899.3 4933.7 4941.1 4954.9 5014.9 5001.4 5048.0 5061.8 5068.3 5112.1 4588.7 4824.3 4865.3 4869.7 4919.0 4713.0 4775.0 4795.0 4815.0 4816.3 4786.4 4798.3 4799.4 4818.2 4842.5 4697.8 4921.4 4927.6 4934.8 4966.5 4683.4 4755.4 4784.8 4835.1 4880.9 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,473 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40038.78 Median:29661.13 stddev:62621.94 (211.1%) stddev-sans-first:62727.48 11:12:23 INFO - 2015-12-16 11:12:23,474 DEBUG : BROWSER_OUTPUT: Values: 569.5 573.2 577.6 579.0 599.7 26768.0 35100.3 35852.1 35980.6 36003.6 38746.8 39008.6 39071.8 39072.8 39090.4 7044.0 7166.3 7876.8 8043.0 8049.6 10052.5 10330.1 10332.8 10333.9 10345.4 9603.5 9732.7 9738.3 9739.6 9740.6 10019.7 10068.5 10120.5 10142.0 10146.6 9767.5 9887.2 9937.0 9937.8 9946.1 37374.4 37628.6 37795.2 37831.4 37865.0 3020.8 3056.2 3572.0 3601.7 3647.6 27979.2 28301.0 28432.8 28546.7 29093.6 3258.8 3275.7 3281.8 3415.3 3437.2 212892.0 213230.0 213612.0 214283.9 214625.9 50346.0 51559.2 52965.7 52980.5 53226.7 62323.0 62825.0 63007.0 63150.7 63226.4 14400.1 14638.0 14649.5 14658.9 14661.7 10086.9 10087.8 10412.1 11169.7 11257.9 17795.5 18003.0 18136.4 18174.1 18213.1 6821.7 7061.6 7066.9 7138.4 7221.9 815.8 892.9 901.5 1016.6 1072.2 25955.6 27106.7 27314.9 27557.9 27571.9 951.4 991.2 1044.3 1078.8 1081.4 12823.1 12873.4 12876.2 13363.2 13411.3 254913.0 258310.0 258767.0 259551.0 259899.0 45165.3 45521.9 45542.5 45576.8 45719.9 1246.1 1259.0 1265.0 1268.9 1272.3 24642.1 25400.0 25983.9 26032.2 26069.9 39357.6 39367.6 39465.4 39814.8 39893.8 245753.0 247901.0 247959.0 248452.0 248831.0 24343.3 28427.0 28651.4 28909.0 29102.5 32909.3 38642.0 39284.4 39855.6 39883.2 29409.7 29494.9 29563.3 29753.0 32565.2 25696.5 28988.9 30873.4 31813.0 33415.2 29689.6 30021.8 30192.1 30471.2 30485.8 26978.0 27182.9 28015.0 29608.3 29632.7 22821.9 23182.8 23341.4 23386.2 23469.2 11:12:23 INFO - 2015-12-16 11:12:23,474 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,474 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26207.19 Median:3771.49 stddev:77525.84 (2055.6%) stddev-sans-first:77718.96 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: Values: 325.1 325.8 329.4 338.5 340.1 12288.4 12586.8 15683.6 16188.7 16969.6 13022.4 15643.3 15735.3 15746.3 15926.0 4830.8 4834.0 4968.1 4976.0 4989.2 3637.5 3766.6 3776.3 3814.6 4932.9 3782.9 3796.5 5573.5 5743.1 5745.7 5220.8 5724.4 5752.9 5765.1 5776.2 5068.4 5079.8 5081.1 5085.3 5089.4 18979.1 19236.0 19385.5 19604.5 19662.1 1837.5 1942.6 1957.7 2014.3 2037.6 12375.8 12393.4 12460.8 12644.7 12693.3 1649.9 1781.2 1787.1 1787.6 1797.9 52866.0 54012.2 54111.5 54623.2 55306.4 9253.9 9371.0 9429.5 9453.5 9544.9 11703.7 11705.7 11707.2 11752.3 11757.1 7301.2 7361.1 7397.7 7430.9 7442.6 7206.7 7237.3 7251.8 7268.1 7282.4 5519.8 5559.7 5569.8 5696.3 5715.8 1583.7 1636.9 1639.9 1660.9 1722.1 862.7 917.7 965.2 982.4 1040.7 15916.4 16322.1 16402.0 16439.7 16555.6 777.2 885.5 915.8 933.5 958.7 9031.0 9233.0 9422.0 9508.7 9527.9 458863.0 469835.0 480161.0 480840.0 483047.0 70488.3 72367.6 73177.3 73307.6 73468.6 1075.4 1098.5 1098.9 1103.9 1126.1 14713.2 15003.5 15178.4 15186.2 15394.9 33195.0 33214.7 33604.2 34572.8 34653.0 44140.3 45663.3 46301.5 46412.3 46953.0 8146.3 8352.9 8357.9 8411.5 8455.5 9712.4 15289.3 15573.8 16114.1 16173.3 13264.9 13295.7 13659.9 13660.9 13861.2 13499.5 13509.9 13750.6 13787.6 14127.0 13633.7 13735.6 13890.0 14504.2 14558.3 8373.7 8430.1 8439.0 8452.7 8560.6 9436.1 12225.2 13207.9 13386.3 14243.4 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5015.84 Median:6345.81 stddev:2590.15 (40.8%) stddev-sans-first:2583.33 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: Values: 1421.3 1609.5 1667.7 1700.1 1743.7 6142.5 7077.2 7284.7 7287.3 7289.6 6916.6 7110.4 7112.3 7113.5 7124.6 1753.1 1783.7 1785.1 2102.5 2140.3 1806.7 2057.6 2085.3 2090.3 2092.4 2057.5 2062.4 2073.6 2074.4 2081.3 2085.9 2095.3 2107.1 2108.4 2113.5 2090.4 2092.1 2116.3 2118.4 2128.1 7158.1 7216.3 7217.5 7221.0 7235.0 4165.7 4244.8 4247.3 4254.5 4255.0 2697.2 2706.9 2772.6 2786.7 2799.7 828.3 843.8 859.9 866.1 872.0 9738.6 9742.4 9743.0 9750.4 9754.2 3924.5 3998.9 4002.1 4009.0 4081.2 8342.1 8346.4 8348.2 8364.8 8371.7 4328.1 4331.6 4341.5 4353.9 4367.5 3906.7 3924.8 3929.6 3934.8 3935.6 3013.2 3075.8 3331.4 3405.3 3405.9 1073.2 1092.5 1096.4 1105.2 1120.5 934.6 935.9 960.4 992.2 1121.4 6797.8 6833.7 6872.8 6883.8 6883.8 1029.1 1052.1 1060.5 1072.1 1088.3 5255.4 5367.7 5373.7 5384.7 5392.0 8249.0 8374.8 8376.7 8441.2 8479.0 8257.7 8283.0 8314.9 8374.0 8386.7 6770.8 6824.6 6881.6 6915.7 6930.4 6749.3 6783.3 6803.2 6809.4 6887.6 7509.8 7734.8 7781.6 7838.6 7841.4 7778.6 7885.4 7934.5 7943.4 8061.1 6500.6 6529.0 6557.5 6578.7 6601.8 5815.4 5922.3 6627.9 6851.7 6907.0 6531.0 6537.4 6632.8 6637.6 6673.2 6417.4 6429.1 6493.5 6569.6 6580.1 6023.2 6341.7 6349.9 6351.4 6367.1 6110.9 6124.7 6136.4 6136.4 6141.1 5998.9 6052.9 6086.6 6090.6 6111.0 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,475 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4641.59 Median:5322.19 stddev:1363.52 (25.6%) stddev-sans-first:1327.79 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: Values: 297.5 299.2 304.7 310.9 311.0 5301.2 5325.7 5384.8 5394.8 5407.1 5272.7 5299.3 5300.6 5307.2 5331.8 3941.5 4106.0 4113.3 4121.4 4122.3 4046.6 4057.8 4160.2 4191.1 4195.6 4134.3 4140.4 4151.0 4151.1 4151.8 3893.4 3973.1 4008.3 4137.2 4152.1 3667.9 3669.4 3673.5 3676.6 3680.6 5068.1 5079.3 5085.9 5089.8 5092.3 4749.4 4752.2 4754.9 4759.2 4761.1 5420.6 5561.2 5569.5 5579.7 5583.3 3983.2 3983.9 3984.7 3986.8 3994.6 5862.6 5868.8 5869.1 5869.9 5880.7 4100.4 4102.1 4104.7 4105.9 4106.8 3718.7 3869.7 4171.4 4172.1 4172.5 4504.6 4517.8 4578.2 4614.1 4699.9 5513.9 5521.3 5582.6 5584.8 5592.8 1392.7 1424.1 1424.3 1424.6 1429.0 965.1 969.9 970.4 986.5 988.2 4904.3 4923.5 4925.4 4930.0 4934.4 5774.8 5776.2 5776.3 5785.2 5785.6 4892.7 4899.4 4900.3 4906.1 4909.3 3035.5 3085.0 3107.4 3111.5 3118.7 5504.9 5562.2 5562.6 5562.7 5568.6 6013.5 6018.4 6019.1 6021.0 6022.2 5544.2 5554.4 5555.9 5557.2 5562.1 5675.3 5822.4 5829.0 5832.5 5834.2 5679.3 5699.8 5700.5 5701.7 5707.3 5539.8 5542.0 5546.4 5559.6 5559.7 3863.8 3930.8 3976.2 3977.7 3989.1 5766.2 5768.3 5773.2 5777.8 5782.6 5523.2 5524.0 5528.4 5531.2 5533.2 5525.9 5544.1 5546.5 5547.1 5547.5 5318.7 5487.4 5487.9 5490.9 5492.5 5360.5 5546.3 5632.2 5638.5 5639.4 5374.4 5493.8 5510.4 5522.7 5528.3 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12006.83 Median:51217.36 stddev:13733.41 (26.8%) stddev-sans-first:13745.94 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: Values: 754.9 759.2 762.6 764.3 765.2 11614.8 11853.9 11881.2 11883.2 11897.2 10757.9 11438.5 11468.7 11496.9 11511.6 640.7 648.6 804.2 815.7 832.9 800.1 806.9 807.1 811.5 821.4 842.5 842.8 843.4 846.2 860.0 666.2 668.8 827.1 831.8 835.8 617.2 617.3 618.3 629.6 637.9 11106.4 11402.0 11404.3 11405.8 11417.5 11205.3 11567.8 11713.8 11793.0 11884.6 9689.1 9705.2 9719.8 9781.0 10112.9 3205.2 3240.2 3240.5 3243.1 3343.1 40440.2 40757.0 40795.6 40873.8 40890.0 9278.4 9422.8 9533.6 9548.7 9593.6 15575.8 15788.8 15789.5 15793.5 15832.8 5831.8 5883.4 5891.9 6025.9 6214.8 3584.7 3619.9 3623.1 3660.7 3673.2 2546.5 2583.2 2587.1 2589.6 2590.0 458.7 458.8 462.5 463.6 466.1 509.5 573.4 582.4 594.8 629.5 7909.4 7950.8 8239.3 8730.5 8756.0 399.9 407.4 427.0 509.6 551.7 3577.6 3817.1 3817.4 3845.3 3970.4 50637.2 50890.5 51123.7 51167.5 51267.2 43797.1 44447.0 44662.3 44924.0 44927.0 39412.8 39956.4 39971.4 40217.8 40507.4 7677.6 7702.6 7853.1 7867.8 8015.5 29233.9 29587.0 29752.9 29777.0 29791.6 34986.0 36515.3 38316.0 38465.6 38845.4 9271.3 9284.4 9419.6 9439.2 9456.8 10233.3 10402.7 10429.1 10436.6 10499.8 9856.8 9932.0 9937.8 9998.1 10187.5 9216.1 9277.0 9460.0 9648.0 9688.0 9368.4 9550.2 9675.6 9758.5 9769.5 8612.2 8774.9 8826.6 8970.1 9134.9 8321.8 8513.7 8580.3 8592.3 8715.8 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:12:23 INFO - 2015-12-16 11:12:23,477 DEBUG : BROWSER_OUTPUT: 11:12:24 INFO - 2015-12-16 11:12:24,213 INFO : Browser exited with error code: 0 11:12:24 INFO - 2015-12-16 11:12:24,232 INFO : Completed test dromaeo_css (00:18:37) 11:12:24 INFO - 2015-12-16 11:12:24,232 INFO : Starting test kraken 11:12:24 INFO - 2015-12-16 11:12:24,232 DEBUG : operating with platform_type : linux_ 11:12:24 INFO - 2015-12-16 11:12:24,232 INFO : Initialising browser for kraken test... 11:12:24 INFO - 2015-12-16 11:12:24,238 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyACWn1/profile http://localhost:47070/getInfo.html 11:12:28 INFO - 2015-12-16 11:12:28,217 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:12:28 INFO - 2015-12-16 11:12:28,217 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:12:28 INFO - 2015-12-16 11:12:28,217 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:12:28 INFO - 2015-12-16 11:12:28,217 DEBUG : BROWSER_OUTPUT: __metrics 11:12:28 INFO - 2015-12-16 11:12:28,326 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] 11:12:28 INFO - 2015-12-16 11:12:28,388 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] 11:12:29 INFO - 2015-12-16 11:12:29,407 INFO : Browser initialized. 11:12:29 INFO - 2015-12-16 11:12:29,408 INFO : Running cycle 1/1 for kraken test... 11:12:29 INFO - 2015-12-16 11:12:29,408 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyACWn1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:12:41 INFO - 2015-12-16 11:12:41,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 11:12:41 INFO - 2015-12-16 11:12:41,448 DEBUG : BROWSER_OUTPUT: 11:12:44 INFO - 2015-12-16 11:12:44,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47070/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:44 INFO - 2015-12-16 11:12:44,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 178245632 11:12:44 INFO - 2015-12-16 11:12:44,676 DEBUG : BROWSER_OUTPUT: 11:12:47 INFO - 2015-12-16 11:12:47,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47070/tests/kraken/driver.html?testName=audio-dft) 11:12:47 INFO - 2015-12-16 11:12:47,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 168202240 11:12:47 INFO - 2015-12-16 11:12:47,988 DEBUG : BROWSER_OUTPUT: 11:12:51 INFO - 2015-12-16 11:12:51,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47070/tests/kraken/driver.html?testName=audio-fft) 11:12:51 INFO - 2015-12-16 11:12:51,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 152707072 11:12:51 INFO - 2015-12-16 11:12:51,580 DEBUG : BROWSER_OUTPUT: 11:12:53 INFO - 2015-12-16 11:12:53,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47070/tests/kraken/driver.html?testName=audio-oscillator) 11:12:54 INFO - 2015-12-16 11:12:54,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 155815936 11:12:54 INFO - 2015-12-16 11:12:54,187 DEBUG : BROWSER_OUTPUT: 11:12:56 INFO - 2015-12-16 11:12:56,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:57 INFO - 2015-12-16 11:12:57,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 157708288 11:12:57 INFO - 2015-12-16 11:12:57,016 DEBUG : BROWSER_OUTPUT: 11:12:59 INFO - 2015-12-16 11:12:59,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47070/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:00 INFO - 2015-12-16 11:13:00,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 156340224 11:13:00 INFO - 2015-12-16 11:13:00,557 DEBUG : BROWSER_OUTPUT: 11:13:03 INFO - 2015-12-16 11:13:03,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47070/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:04 INFO - 2015-12-16 11:13:04,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 159518720 11:13:04 INFO - 2015-12-16 11:13:04,572 DEBUG : BROWSER_OUTPUT: 11:13:07 INFO - 2015-12-16 11:13:07,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47070/tests/kraken/driver.html?testName=json-parse-financial) 11:13:08 INFO - 2015-12-16 11:13:08,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 159191040 11:13:08 INFO - 2015-12-16 11:13:08,049 DEBUG : BROWSER_OUTPUT: 11:13:09 INFO - 2015-12-16 11:13:09,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:10 INFO - 2015-12-16 11:13:10,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 169799680 11:13:10 INFO - 2015-12-16 11:13:10,417 DEBUG : BROWSER_OUTPUT: 11:13:12 INFO - 2015-12-16 11:13:12,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:12 INFO - 2015-12-16 11:13:12,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 169340928 11:13:12 INFO - 2015-12-16 11:13:12,915 DEBUG : BROWSER_OUTPUT: 11:13:15 INFO - 2015-12-16 11:13:15,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:15 INFO - 2015-12-16 11:13:15,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 179527680 11:13:15 INFO - 2015-12-16 11:13:15,641 DEBUG : BROWSER_OUTPUT: 11:13:18 INFO - 2015-12-16 11:13:18,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:18 INFO - 2015-12-16 11:13:18,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 183242752 11:13:18 INFO - 2015-12-16 11:13:18,773 DEBUG : BROWSER_OUTPUT: 11:13:21 INFO - 2015-12-16 11:13:21,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:21 INFO - 2015-12-16 11:13:21,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 181071872 11:13:21 INFO - 2015-12-16 11:13:21,963 DEBUG : BROWSER_OUTPUT: 11:13:23 INFO - 2015-12-16 11:13:23,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47070/tests/kraken/driver.html?testName=ai-astar) 11:13:24 INFO - 2015-12-16 11:13:24,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 240766976 11:13:24 INFO - 2015-12-16 11:13:24,004 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:13:24 INFO - 2015-12-16 11:13:24,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;111;114;116;114;104;118;113;121 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;131;161;171;133;163;151;144;171;132 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;162;162;163;163;166;163;162 11:13:24 INFO - 2015-12-16 11:13:24,006 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;87;90;74;71;71;105;93;73 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;134;95;96;95;133;95;96;130 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;110;109;109;110 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;148;147;148;148;147;147;147 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;95;95;96;96 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;74;74;74;74;82;71;73 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;69;69;69;69;68 11:13:24 INFO - 2015-12-16 11:13:24,007 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;87;87;86;86;85;86;86;85 11:13:24 INFO - 2015-12-16 11:13:24,008 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;137;120;121;127;128;127;119;124;125 11:13:24 INFO - 2015-12-16 11:13:24,008 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;148;161;148;137;154;149;148;137 11:13:24 INFO - 2015-12-16 11:13:24,008 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;73;70;73;71;69;72;73;73 11:13:24 INFO - 2015-12-16 11:13:24,008 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:13:24 INFO - 2015-12-16 11:13:24,008 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:13:24 INFO - 2015-12-16 11:13:24,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1002 11:13:24 INFO - 2015-12-16 11:13:24,009 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:13:24 INFO - 2015-12-16 11:13:24,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293204004__endTimestamp 11:13:24 INFO - 2015-12-16 11:13:24,009 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,012 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:13:24 INFO - 2015-12-16 11:13:24,012 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:13:24 INFO - 2015-12-16 11:13:24,012 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:4.47 (3.9%) stddev-sans-first:4.73 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 111.0 114.0 116.0 114.0 104.0 118.0 113.0 121.0 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.50 stddev:15.56 (9.9%) stddev-sans-first:16.50 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: Values: 152.0 131.0 161.0 171.0 133.0 163.0 151.0 144.0 171.0 132.0 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 162.0 162.0 163.0 163.0 166.0 163.0 162.0 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:12.07 (16.4%) stddev-sans-first:12.38 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 87.0 90.0 74.0 71.0 71.0 105.0 93.0 73.0 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:95.00 stddev:17.93 (18.9%) stddev-sans-first:18.53 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 134.0 95.0 96.0 95.0 133.0 95.0 96.0 130.0 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,013 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 147.0 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:2.96 (4.0%) stddev-sans-first:3.14 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 74.0 74.0 74.0 74.0 82.0 71.0 73.0 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 11:13:24 INFO - 2015-12-16 11:13:24,014 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 87.0 87.0 86.0 86.0 85.0 86.0 86.0 85.0 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.32 (4.2%) stddev-sans-first:5.45 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: Values: 121.0 137.0 120.0 121.0 127.0 128.0 127.0 119.0 124.0 125.0 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,015 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.00 stddev:7.97 (5.4%) stddev-sans-first:7.48 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 148.0 161.0 148.0 137.0 154.0 149.0 148.0 137.0 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.50 stddev:1.51 (2.1%) stddev-sans-first:1.48 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 73.0 70.0 73.0 71.0 69.0 72.0 73.0 73.0 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:13:24 INFO - 2015-12-16 11:13:24,016 DEBUG : BROWSER_OUTPUT: 11:13:24 INFO - 2015-12-16 11:13:24,949 INFO : Browser exited with error code: 0 11:13:25 INFO - 2015-12-16 11:13:25,006 INFO : Completed test kraken (00:01:00) 11:13:25 INFO - 2015-12-16 11:13:25,006 INFO : Starting test v8_7 11:13:25 INFO - 2015-12-16 11:13:25,006 DEBUG : operating with platform_type : linux_ 11:13:25 INFO - 2015-12-16 11:13:25,007 INFO : Initialising browser for v8_7 test... 11:13:25 INFO - 2015-12-16 11:13:25,013 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGEOygp/profile http://localhost:47070/getInfo.html 11:13:29 INFO - 2015-12-16 11:13:29,275 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:29 INFO - 2015-12-16 11:13:29,276 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:29 INFO - 2015-12-16 11:13:29,276 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:13:29 INFO - 2015-12-16 11:13:29,276 DEBUG : BROWSER_OUTPUT: __metrics 11:13:29 INFO - 2015-12-16 11:13:29,364 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] 11:13:29 INFO - 2015-12-16 11:13:29,440 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] 11:13:30 INFO - 2015-12-16 11:13:30,332 INFO : Browser initialized. 11:13:30 INFO - 2015-12-16 11:13:30,332 INFO : Running cycle 1/1 for v8_7 test... 11:13:30 INFO - 2015-12-16 11:13:30,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGEOygp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:42 INFO - 2015-12-16 11:13:42,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 142454784 11:13:42 INFO - 2015-12-16 11:13:42,340 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47070/tests/v8_7/run.html (next: http://localhost:47070/tests/v8_7/run.html) 11:14:03 INFO - 2015-12-16 11:14:03,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 441954304 11:14:03 INFO - 2015-12-16 11:14:03,971 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,972 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:03 INFO - 2015-12-16 11:14:03,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.6019779809666 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 11:14:03 INFO - 2015-12-16 11:14:03,973 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: |7;RegExp;27567.567567567567 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: |8;Splay;611.9951040391677 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 11:14:03 INFO - 2015-12-16 11:14:03,974 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:03 INFO - 2015-12-16 11:14:03,975 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293243971__endTimestamp 11:14:03 INFO - 2015-12-16 11:14:03,975 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,975 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:03 INFO - 2015-12-16 11:14:03,975 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: Values: 166.0 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.60 Median:186.60 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,976 DEBUG : BROWSER_OUTPUT: Values: 186.6 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: Values: 278.2 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,977 DEBUG : BROWSER_OUTPUT: Values: 5138.5 11:14:03 INFO - 2015-12-16 11:14:03,978 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,978 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,978 DEBUG : BROWSER_OUTPUT: Values: 2002.0 11:14:03 INFO - 2015-12-16 11:14:03,978 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,978 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,979 DEBUG : BROWSER_OUTPUT: Values: 796.8 11:14:03 INFO - 2015-12-16 11:14:03,979 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,980 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,980 DEBUG : BROWSER_OUTPUT: Values: 12195.1 11:14:03 INFO - 2015-12-16 11:14:03,980 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,980 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27567.57 Median:27567.57 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: Values: 27567.6 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.00 Median:612.00 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: Values: 612.0 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: Values: 4850.2 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:03 INFO - 2015-12-16 11:14:03,981 DEBUG : BROWSER_OUTPUT: 11:14:04 INFO - 2015-12-16 11:14:04,921 INFO : Browser exited with error code: 0 11:14:04 INFO - 2015-12-16 11:14:04,933 INFO : Completed test v8_7 (00:00:39) 11:14:05 INFO - 2015-12-16 11:14:05,020 INFO : Completed test suite (00:20:18) 11:14:05 INFO - 2015-12-16 11:14:05,020 DEBUG : Working with test: dromaeo_css 11:14:05 INFO - 2015-12-16 11:14:05,021 DEBUG : Generating results file: dromaeo_css 11:14:05 INFO - 2015-12-16 11:14:05,022 DEBUG : Working with test: kraken 11:14:05 INFO - 2015-12-16 11:14:05,022 DEBUG : Generating results file: kraken 11:14:05 INFO - 2015-12-16 11:14:05,022 INFO : javascript benchmark 11:14:05 INFO - 2015-12-16 11:14:05,022 DEBUG : Working with test: v8_7 11:14:05 INFO - 2015-12-16 11:14:05,022 DEBUG : Generating results file: v8_7 11:14:05 INFO - 2015-12-16 11:14:05,023 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:05 INFO - 2015-12-16 11:14:05,101 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:14:05 INFO - 2015-12-16 11:14:05,102 DEBUG : process_Request line: dromaeo_css 6323.64 graph.html#tests=[[72,132,35]] 11:14:05 INFO - 2015-12-16 11:14:05,102 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:05 INFO - 2015-12-16 11:14:05,145 DEBUG : process_Request line: kraken 1539.10 graph.html#tests=[[232,132,35]] 11:14:05 INFO - 2015-12-16 11:14:05,145 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:05 INFO - 2015-12-16 11:14:05,175 DEBUG : process_Request line: v8_7 19707.20 graph.html#tests=[[230,132,35]] 11:14:05 INFO - 2015-12-16 11:14:05,177 INFO : javascript benchmark 11:14:05 INFO - 2015-12-16 11:14:05,180 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.659054322938, 2701.5812549054904, 2710.7018227994918, 2712.55242884924, 2731.740484653958, 4475.731456112636, 4569.291759777231, 4655.138799322123, 4713.552212539807, 4730.787114579844, 4554.362389265505, 4596.81612735491, 4698.600618947385, 4698.90602187956, 4745.050989802036, 4304.591063848945, 4349.021470169202, 4352.325389564615, 4355.36847157162, 4367.781610919457, 4213.5786421357925, 4445.866624001285, 4450.532694067125, 4504.481984571784, 4507.188706032913, 4289.528151903288, 4352.39066530686, 4358.978205108986, 4365.43249377582, 4396.406485124499, 4364.323529852878, 4371.781410929472, 4386.539413361583, 4403.0, 4446.533114023014, 4163.167366526676, 4280.507741609724, 4360.040791026001, 4380.496242932039, 4436.0906014267, 4508.729476231437, 4552.0, 4590.127875703605, 4626.791794369262, 4631.58315751584, 5051.621128415383, 5052.671576347562, 5067.163917953533, 5072.695638261716, 5109.131447653871, 4874.512548745132, 5099.36257967754, 5101.0, 5103.464136265676, 5105.0, 4644.396228490308, 4644.651651126179, 4662.090892276007, 4723.5984941279685, 4773.236282194902, 5187.144121219956, 5222.086134926372, 5229.294045303835, 5230.424653288135, 5233.1365324721755, 4887.193613053806, 5009.173486374781, 5029.673071250357, 5032.3961124665275, 5072.898542029138, 4999.700017998932, 5009.298698182258, 5012.523810238022, 5069.518395752398, 5086.491350864958, 5000.1249781288125, 5010.248462730547, 5013.674111182761, 5014.122528557488, 5052.646314758005, 4775.140474714515, 4970.204767237225, 4975.378077740283, 4978.178600530872, 5023.6985780853265, 4108.630223279919, 4140.192662430857, 4151.46031015972, 4163.333866581333, 4174.415581818548, 3679.466477360768, 3680.2639472105684, 3681.5029970954115, 3699.352613292663, 3714.201446688975, 4160.895977600584, 4361.629261512807, 4371.803268852909, 4390.692651514363, 4401.515833258339, 4836.129496690559, 4911.091448082117, 4915.754212289371, 4986.501349864984, 5035.043341765127, 4286.592773686495, 4320.092780516064, 4335.219660461147, 4335.4363932689175, 4378.956210437918, 4262.211490874198, 4454.888627784331, 4455.086707225011, 4455.844045458393, 4487.214737420938, 4677.7193368398, 4697.95302046982, 4716.033213191287, 4736.976315118402, 4788.305695674038, 5018.04657115147, 5064.645474816727, 5065.417476990193, 5068.949310506995, 5110.97444512775, 4655.604273636779, 4803.039392121659, 4814.037192561432, 4818.10864989978, 4855.028994201244, 4899.265110233494, 4933.654644174873, 4941.110600092018, 4954.900901982012, 5014.9498505015945, 5001.449840517467, 5048.0156369507595, 5061.822836200715, 5068.341115654941, 5112.105381558138, 4588.701734387254, 4824.300476430968, 4865.318855360181, 4869.70781753096, 4918.950810491992, 4712.976435117803, 4774.997250577418, 4794.952050479451, 4814.9518504814505, 4816.301636262792, 4786.425628924551, 4798.3042458843975, 4799.400074990626, 4818.229083346648, 4842.491538388418, 4697.8355757548325, 4921.409430868319, 4927.556519913225, 4934.753262336797, 4966.528179822911, 4683.367745354333, 4755.38180036593, 4784.808607655655, 4835.081334546425, 4880.926786098283], "unit": "score", "name": "dojo.html", "value": 4606.154385737177}, {"lowerIsBetter": false, "replicates": [569.4732372555386, 573.1917995626167, 577.5552824325267, 578.9971050144749, 599.7121381736766, 26768.0, 35100.297994040106, 35852.103697407576, 35980.640193598054, 36003.639963600355, 38746.8062659687, 39008.60991390085, 39071.804640976756, 39072.80463597685, 39090.41364379529, 7044.0, 7166.283371662844, 7876.763697089096, 8043.03483581971, 8049.6377663005305, 10052.49737513125, 10330.121939635103, 10332.845007324897, 10333.896661033406, 10345.379277243352, 9603.4718090505, 9732.65935692251, 9738.26962977776, 9739.56171972263, 9740.610375584969, 10019.749506262366, 10068.496575171212, 10120.544575494121, 10142.0, 10146.594136234542, 9767.462789546573, 9887.159591434665, 9936.95031524845, 9937.75155621108, 9946.104850563412, 37374.43938340927, 37628.62371376306, 37795.244095117945, 37831.432528512094, 37865.0, 3020.8338541380217, 3056.190109620952, 3571.964280357189, 3601.7478776485655, 3647.6170002149656, 27979.155643849044, 28301.025320350425, 28432.751550210964, 28546.714532854614, 29093.563596546068, 3258.804471731704, 3275.7215636670912, 3281.835908204604, 3415.26571787067, 3437.157896315419, 212892.0, 213230.0, 213612.0, 214283.9285803561, 214625.9268703662, 50346.0, 51559.226611600854, 52965.70342965673, 52980.47019529832, 53226.7338663312, 62323.0, 62825.0, 63007.0, 63150.68424657939, 63226.36773632205, 14400.135991840523, 14638.0, 14649.487267945784, 14658.853411465961, 14661.706765864623, 10086.949565252127, 10087.798244035079, 10412.062914337594, 11169.664910052712, 11257.887421125848, 17795.46613601594, 18003.0, 18136.365227216986, 18174.09129543544, 18213.08934553267, 6821.69302381394, 7061.611611361322, 7066.92933070673, 7138.428925686037, 7221.89167162493, 815.8327542853701, 892.9464232146092, 901.5176880368971, 1016.5781200801732, 1072.1797824664138, 25955.610665840028, 27106.728932710816, 27314.863425683143, 27557.862210689218, 27571.86214068957, 951.4196340232453, 991.2317953586029, 1044.300318786415, 1078.7788503356794, 1081.3944191252924, 12823.139620303093, 12873.420696068699, 12876.163049401759, 13363.198208107544, 13411.262380568967, 254913.0, 258310.0, 258767.0, 259551.0, 259899.0, 45165.322520162226, 45521.85454963604, 45542.54457455449, 45576.772116139204, 45719.88521033056, 1246.0965799795258, 1258.9937050314873, 1265.0385706862667, 1268.8731126887237, 1272.3002348708173, 24642.137525186532, 25400.0, 25983.870080649474, 26032.219033429028, 26069.869650651624, 39357.606423935395, 39367.606323937536, 39465.40801887916, 39814.80092599519, 39893.800530997156, 245753.0, 247901.0, 247959.0, 248452.0, 248831.0, 24343.269701908972, 28427.0, 28651.42697146087, 28909.0, 29102.5448727567, 32909.34181316408, 38642.0, 39284.410733839584, 39855.60144398635, 39883.2023359537, 29409.705902940696, 29494.852525737235, 29563.26091847721, 29753.0, 32565.18587035343, 25696.486070278865, 28988.85505572543, 30873.382532349675, 31813.0, 33415.1646208837, 29689.554656679735, 30021.84989075128, 30192.09423717292, 30471.238219044702, 30485.847570762005, 26978.0, 27182.864085680238, 28014.96195021324, 29608.259793505335, 29632.703672962994, 22821.88589057044, 23182.76817231806, 23341.41646458852, 23386.18148364799, 23469.178578749663], "unit": "score", "name": "ext.html", "value": 17093.95975960016}, {"lowerIsBetter": false, "replicates": [325.1448689945443, 325.8077734136859, 329.40049110618673, 338.4564994069566, 340.1496259351621, 12288.385580720973, 12586.81119783204, 15683.607909802246, 16188.65455780343, 16969.575760605974, 13022.413991370388, 15643.296051677673, 15735.291911863966, 15746.291416886239, 15926.0, 4830.758462076899, 4833.9516604834025, 4968.130577148984, 4975.950240497603, 4989.151844186497, 3637.4543818427182, 3766.642168993941, 3776.339140650389, 3814.5994670559608, 4932.926006109911, 3782.8865134046023, 3796.468494410785, 5573.470520300585, 5743.081107022877, 5745.6552606843725, 5220.843374698765, 5724.398938111501, 5752.856178595548, 5765.077587586008, 5776.249087618625, 5068.366454193226, 5079.847604571832, 5081.085404627165, 5085.313482679865, 5089.3638295213095, 18979.145938432805, 19236.0, 19385.51536211592, 19604.50988725279, 19662.11520481582, 1837.4671345309844, 1942.5726340205133, 1957.745493085904, 2014.2547257514666, 2037.572109856917, 12375.75248495034, 12393.442295096653, 12460.81308780369, 12644.747105057848, 12693.301868397235, 1649.934002639893, 1781.2251670523235, 1787.0885848217372, 1787.6235298819965, 1797.8741488095839, 52866.0, 54012.18981715277, 54111.458885411426, 54623.18065229025, 55306.446935530534, 9253.861192082124, 9370.95314523423, 9429.48137852411, 9453.480058596706, 9544.904550954541, 11703.654079780934, 11705.707357316136, 11707.180497365103, 11752.294862308117, 11757.118216133824, 7301.2333704961275, 7361.116666000007, 7397.667104980289, 7430.851382972419, 7442.553446793209, 7206.675699593531, 7237.312455316736, 7251.8187045324285, 7268.0914885639295, 7282.417406607458, 5519.806806761744, 5559.694216818033, 5569.832905012856, 5696.3449203341315, 5715.771369145271, 1583.6832633473352, 1636.869050475959, 1639.9262033208533, 1660.867130629571, 1722.0786879019665, 862.7109918177356, 917.7476194046691, 965.2471072563412, 982.3958265666564, 1040.7138037039724, 15916.389093882679, 16322.102284374236, 16402.0, 16439.67120657604, 16555.586110347096, 777.2072486064296, 885.4908427654125, 915.8259930613162, 933.453929451265, 958.7171784323641, 9030.954845225731, 9232.95383523078, 9421.952890235505, 9508.714738557854, 9527.904720952702, 458863.0, 469835.0, 480161.0, 480840.0, 483047.0, 70488.2951170492, 72367.63816180885, 73177.26822731705, 73307.63346183342, 73468.63265683637, 1075.4461452352045, 1098.4837126550508, 1098.906592939593, 1103.900648941599, 1126.0934947367448, 14713.190774507504, 15003.474878379204, 15178.392864285304, 15186.164760938254, 15394.923025384802, 33195.0, 33214.66785332116, 33604.15989600182, 34572.82713586416, 34653.0, 44140.33789493096, 45663.31505027361, 46301.536984629725, 46412.30381544347, 46952.98637653708, 8146.266835984789, 8352.874706879524, 8357.874631880404, 8411.53736544496, 8455.450395724258, 9712.417254964725, 15289.311980960661, 15573.766393504333, 16114.113723745306, 16173.272202751139, 13264.867351326364, 13295.66760830987, 13659.86340136586, 13660.93169534146, 13861.237631929936, 13499.460021599027, 13509.932450337685, 13750.587482375544, 13787.586372408843, 14127.0, 13633.727325453634, 13735.587932362045, 13890.0, 14504.202268875313, 14558.27208639585, 8373.66505339804, 8430.072692003752, 8439.029511606244, 8452.661893524437, 8560.571971401281, 9436.103570160823, 12225.20536165182, 13207.867921320663, 13386.330683465592, 14243.35904884262], "unit": "score", "name": "jquery.html", "value": 8414.375181009465}, {"lowerIsBetter": false, "replicates": [1421.3106643278015, 1609.5493261886672, 1667.6581300833327, 1700.124435915503, 1743.7471566622849, 6142.508599312056, 7077.150741910971, 7284.745033923814, 7287.27127287271, 7289.635518224094, 6916.58500489971, 7110.395616372602, 7112.253213412595, 7113.5376200546925, 7124.572525648465, 1753.132199561219, 1783.652187823375, 1785.1342099082, 2102.4743814046487, 2140.2616097446357, 1806.7380229866726, 2057.6090542796896, 2085.3326935380683, 2090.289301637443, 2092.3932059702743, 2057.495913501187, 2062.443140352104, 2073.5749171419898, 2074.3776866939934, 2081.344376521391, 2085.9165633374646, 2095.298075144821, 2107.1150116950917, 2108.4307237045987, 2113.450502869265, 2090.3937858021154, 2092.058573641867, 2116.280464642029, 2118.385668156233, 2128.074287684862, 7158.141023077264, 7216.278372162794, 7217.494775365726, 7221.0, 7235.023271858285, 4165.687573432005, 4244.766537840417, 4247.27796274631, 4254.489461264668, 4255.0, 2697.2178068360154, 2706.91879243623, 2772.625695531118, 2786.6934637190097, 2799.664040315155, 828.2711214131525, 843.7848348671049, 859.879616853641, 866.0992567729554, 871.9782005449852, 9738.561764720534, 9742.415455072647, 9743.0, 9750.366226195345, 9754.170895473893, 3924.489816323917, 3998.900027499336, 4002.139539998914, 4008.9799551002056, 4081.2449696806184, 8342.124076971952, 8346.415750897379, 8348.206920342558, 8364.790880227922, 8371.665133394717, 4328.09110086879, 4331.631811296075, 4341.45731783527, 4353.934690979638, 4367.519572846984, 3906.68746500285, 3924.7841368724994, 3929.6070392960473, 3934.822932967966, 3935.6064393560987, 3013.186439661323, 3075.815451072943, 3331.383694016566, 3405.2848901730417, 3405.9318813624086, 1073.1897417449932, 1092.5138313450598, 1096.4298564746287, 1105.1876870500175, 1120.467777805552, 934.5654270764128, 935.8596210568469, 960.3901522533102, 992.161623428202, 1121.388843080523, 6797.796066117926, 6833.658317084126, 6872.828179295458, 6883.759068432681, 6883.827904302432, 1029.0812200120004, 1052.0636633396284, 1060.4909643371225, 1072.0512346573182, 1088.3361149698678, 5255.421903590602, 5367.677939323653, 5373.731313434313, 5384.703841288767, 5391.973040134774, 8249.0, 8374.832503349899, 8376.664933402717, 8441.198086181803, 8479.0, 8257.710980115788, 8283.0, 8314.916850831536, 8373.95813020931, 8386.748397548083, 6770.763023294161, 6824.590524568542, 6881.552699074544, 6915.654217289115, 6930.410915072275, 6749.257581666111, 6783.253842077269, 6803.183617965876, 6809.353111454404, 6887.552309099892, 7509.812254693677, 7734.845303093794, 7781.610919454118, 7838.568878711726, 7841.4118941078505, 7778.572178530235, 7885.408594355561, 7934.523928564305, 7943.364530837403, 8061.072976607765, 6500.577462464925, 6529.0, 6557.508186885907, 6578.7368505261165, 6601.768938087144, 5815.447532484407, 5922.2597175353085, 6627.867442651216, 6851.657417129223, 6907.033015377951, 6530.967345163243, 6537.411632953057, 6632.767853125118, 6637.601743895381, 6673.165854268216, 6417.358264173546, 6429.132067170872, 6493.545451818516, 6569.638669873203, 6580.1116849224745, 6023.156758053964, 6341.746330146742, 6349.8730025400155, 6351.428371446592, 6367.108604795239, 6110.938890611214, 6124.663143527148, 6136.386361364007, 6136.417040381157, 6141.109539116714, 5998.940010599838, 6052.909206361996, 6086.604370716066, 6090.573659843769, 6110.969445152746], "unit": "score", "name": "mootools.html", "value": 4116.917623517362}, {"lowerIsBetter": false, "replicates": [297.49871466578804, 299.1906891857527, 304.6983486348515, 310.88652641785745, 310.973567246784, 5301.151815709487, 5325.653832500885, 5384.8115315964, 5394.811181608645, 5407.134858422653, 5272.710000949946, 5299.33758280215, 5300.602454815885, 5307.177387504943, 5331.840044798662, 3941.507311586052, 4105.97947010266, 4113.341865301552, 4121.443605113316, 4122.340425531908, 4046.6155715207155, 4057.8376864925367, 4160.209560183571, 4191.098913733546, 4195.601417865298, 4134.3178375567995, 4140.358244472111, 4151.045259590296, 4151.066010147722, 4151.813168407414, 3893.357595996657, 3973.0663294125857, 4008.2584721826265, 4137.1725654869, 4152.1280531088505, 3667.889963301105, 3669.412893936957, 3673.4673472346626, 3676.5588129424373, 3680.576733675635, 5068.087744206042, 5079.339685840854, 5085.8728531787, 5089.796408143669, 5092.3125378073855, 4749.382580264578, 4752.215884379108, 4754.904901901942, 4759.23852183649, 4761.0715910397485, 5420.647657902263, 5561.165825126223, 5569.498745112919, 5579.688773138309, 5583.274174357348, 3983.183447393277, 3983.900402489932, 3984.6613037891525, 3986.80065996699, 3994.6404823566018, 5862.560307976919, 5868.794592189253, 5869.148973398876, 5869.853253668693, 5880.705964701748, 4100.36444351126, 4102.097538541516, 4104.671626269891, 4105.856295029719, 4106.835726570904, 3718.665320121148, 3869.709771767072, 4171.374293855946, 4172.102997855475, 4172.520160181557, 4504.572065653758, 4517.81928722854, 4578.175928332932, 4614.123316569841, 4699.929501057487, 5513.862153446196, 5521.282233309725, 5582.581306402036, 5584.804531841366, 5592.7762889483965, 1392.6657602175405, 1424.0743516714012, 1424.2522675595396, 1424.64383904024, 1429.0425414971994, 965.0879918476971, 969.888462826784, 970.4225985538593, 986.5116767200138, 988.2143695761742, 4904.2643603459765, 4923.532264434873, 4925.408950925912, 4930.0, 4934.383202099738, 5774.769009239667, 5776.249087618583, 5776.33572139201, 5785.218995435646, 5785.566082543826, 4892.730899800546, 4899.363082799213, 4900.313956046157, 4906.11689895815, 4909.263610458388, 3035.4839677254918, 3085.0, 3107.409592177479, 3111.471049921519, 3118.7037231462973, 5504.889902201933, 5562.249096372019, 5562.554995600342, 5562.694051827189, 5568.638038527482, 6013.548983826143, 6018.398160183947, 6019.097135429721, 6021.036634138517, 6022.18700475439, 5544.1960915667805, 5554.389017208104, 5555.916661250085, 5557.166425036277, 5562.082256427644, 5675.262215911905, 5822.359540450631, 5829.0090684584575, 5832.533397328289, 5834.241548598655, 5679.261695979661, 5699.829005129853, 5700.515456186271, 5701.7149142541875, 5707.343655479673, 5539.806106786243, 5541.972290138524, 5546.362168350692, 5559.610827242054, 5559.749811258584, 3863.787491687872, 3930.803459827054, 3976.2047590481443, 3977.6618987386396, 3989.06257029592, 5766.192733017297, 5768.307803063659, 5773.249477568057, 5777.7977770777825, 5782.624129431573, 5523.171524271392, 5524.0, 5528.4471552846, 5531.197976293495, 5533.170024496197, 5525.889482210414, 5544.085225937675, 5546.473085056913, 5547.11246200606, 5547.528460080777, 5318.7340632967425, 5487.368952570506, 5487.890242195054, 5490.945090549043, 5492.505674489315, 5360.490753378579, 5546.306711661043, 5632.239647647679, 5638.4925356718095, 5639.379668236573, 5374.435684253097, 5493.780248790164, 5510.448955104457, 5522.723863806874, 5528.308961379827], "unit": "score", "name": "prototype.html", "value": 4202.846165328992}, {"lowerIsBetter": false, "replicates": [754.9396048316133, 759.1649185895516, 762.5920132728991, 764.3197554176784, 765.1736124985017, 11614.825777613332, 11853.940730296337, 11881.227720198192, 11883.22759020663, 11897.226680265798, 10757.946210268958, 11438.542458301657, 11468.71328216795, 11496.942515287412, 11511.597094101688, 640.7180840430219, 648.6270394523144, 804.1877703519458, 815.7226542975387, 832.8917240758693, 800.0719165767711, 806.9273765361116, 807.1000834069999, 811.5212024905304, 821.4496287487398, 842.5239739547167, 842.8314337132598, 843.3548335523329, 846.2045677063571, 859.9570021498931, 666.2471407309757, 668.812732434919, 827.0860698927659, 831.8128421105264, 835.8119423129808, 617.2438762515927, 617.3425302053299, 618.2519151826295, 629.5624540944045, 637.9298277189505, 11106.44467776616, 11402.030827379682, 11404.315741055563, 11405.771884562346, 11417.543298268143, 11205.271657342328, 11567.76864462706, 11713.765724685458, 11793.0, 11884.643460696107, 9689.12797848197, 9705.223582113415, 9719.757006074835, 9780.951095244478, 10112.89887101127, 3205.2307446212976, 3240.238543942172, 3240.5139229115584, 3243.124356423776, 3343.1307859956587, 40440.19119617591, 40757.0, 40795.59204407947, 40873.79563102195, 40890.0, 9278.371055148264, 9422.811543769087, 9533.570989305497, 9548.713538593853, 9593.616255349707, 15575.766363504557, 15788.763168552481, 15789.526314210592, 15793.526194214191, 15832.76250856238, 5831.7667293307795, 5883.352831188566, 5891.911621325684, 6025.879482410327, 6214.751409943552, 3584.6594573515476, 3619.8914032579064, 3623.112337477335, 3660.7254455915913, 3673.246984368198, 2546.5288921549572, 2583.1733845169742, 2587.0815860369676, 2589.572720501134, 2589.9870500647376, 458.7362266696663, 458.8371128249423, 462.4750907719762, 463.6406784741852, 466.1004261774807, 509.52868596548046, 573.3635664412499, 582.3826743651742, 594.8007417515181, 629.5247088448192, 7909.446338756347, 7950.801229969182, 8239.258466738022, 8730.519821409756, 8756.0, 399.920015996796, 407.3604441027558, 426.9778684789292, 509.5781825044768, 551.7461967494997, 3577.6422357764013, 3817.141143242748, 3817.351050321452, 3845.307844587945, 3970.4242884781543, 50637.240441393405, 50890.49109508932, 51123.74438127786, 51167.48832511702, 51267.23099153516, 43797.12405751931, 44447.0, 44662.33006504905, 44924.0, 44927.0, 39412.802935985135, 39956.40065399021, 39971.40042899359, 40217.79891100584, 40507.39238911419, 7677.558520412346, 7702.614869256627, 7853.1361550228285, 7867.763967080997, 8015.47899386538, 29233.85383073071, 29587.0, 29752.85123574368, 29777.0, 29791.55312670268, 34986.0, 36515.26969460649, 38316.0, 38465.61534384732, 38845.417318739674, 9271.305637539304, 9284.350095493252, 9419.576119074522, 9439.244860411014, 9456.763580910532, 10233.334833235816, 10402.739931501774, 10429.11352535043, 10436.582536698446, 10499.845017047966, 9856.753581160528, 9932.0, 9937.801243975224, 9998.100170984646, 10187.490625468548, 9216.07839216073, 9277.0, 9460.0, 9647.951760241154, 9687.951560242154, 9368.4378937264, 9550.235981121356, 9675.564599592895, 9758.46328451942, 9769.511524423893, 8612.224899759052, 8774.868376974478, 8826.646934122564, 8970.147835955573, 9134.862977055482, 8321.83356332882, 8513.702020429255, 8580.313574914117, 8592.31261499066, 8715.825683486422], "unit": "score", "name": "yui.html", "value": 5577.480718726885}], "name": "dromaeo_css", "value": 6323.639696536793}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 111.0, 114.0, 116.0, 114.0, 104.0, 118.0, 113.0, 121.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 161.0, 171.0, 133.0, 163.0, 151.0, 144.0, 171.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0, 166.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 87.0, 90.0, 74.0, 71.0, 71.0, 105.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 134.0, 95.0, 96.0, 95.0, 133.0, 95.0, 96.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 74.0, 74.0, 74.0, 74.0, 82.0, 71.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 87.0, 86.0, 86.0, 85.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [121.0, 137.0, 120.0, 121.0, 127.0, 128.0, 127.0, 119.0, 124.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 148.0, 161.0, 148.0, 137.0, 154.0, 149.0, 148.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 73.0, 70.0, 73.0, 71.0, 69.0, 72.0, 73.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1539.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [186.6019779809666], "unit": "score", "name": "DeltaBlue", "value": 354.3263619999999}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [27567.567567567567], "unit": "score", "name": "RegExp", "value": 33.04553431372551}, {"lowerIsBetter": false, "replicates": [611.9951040391677], "unit": "score", "name": "Splay", "value": 133.15629400000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19707.200952127478}]} 11:14:05 INFO - RETURN: dromaeo_css: 6323.64 11:14:05 INFO - RETURN: kraken: 1539.10 11:14:05 INFO - RETURN: v8_7: 19707.20 11:14:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19707.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1539.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6323.64"}}} 11:14:05 INFO - Return code: 0 11:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:14:05 ERROR - # TBPL SUCCESS # 11:14:05 INFO - Running post-action listener: _resource_record_post_action 11:14:05 INFO - Running post-run listener: _resource_record_post_run 11:14:06 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509038592; Read time: 16; Write time: 601940 11:14:06 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231501824; Read time: 0; Write time: 420232 11:14:06 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277536768; Read time: 16; Write time: 181708 11:14:06 INFO - Running post-run listener: _upload_blobber_files 11:14:06 INFO - Blob upload gear active. 11:14:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:14:06 INFO - Copying logs to upload dir... 11:14:06 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.384006 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-16 11:14:05.690054) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:14:05.693545) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010032 build_url: 'https://queue.taskcluster.net/v1/task/WIfTidvEQyKLDX1YY6TD2g/artifacts/public/build/firefox-46.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-16 11:14:05.746036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:14:05.746456) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450290431.746184-418370649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:14:05.797051) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:14:05.797384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:14:05.797705) ========= ========= Total master_lag: 0.30 =========