builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1449902137.78 results: success (0) buildid: 20151211213131 builduid: 9d34c61704e44a82b3990521515adf3a revision: 6c24ecacc1a9c5e9c054c074269f808d587ee29c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.778020) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.778670) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.779120) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004243 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.827413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.827743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.846883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.847225) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037377 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.895291) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.895609) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.896044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.896450) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 22:35:37-- 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% 226M=0s 2015-12-11 22:35:38 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.106361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.106752) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.262612 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.384561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.385202) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6c24ecacc1a9c5e9c054c074269f808d587ee29c --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 6c24ecacc1a9c5e9c054c074269f808d587ee29c --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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 22:35:38,470 truncating revision to first 12 chars 2015-12-11 22:35:38,470 Setting DEBUG logging. 2015-12-11 22:35:38,471 attempt 1/10 2015-12-11 22:35:38,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6c24ecacc1a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 22:35:39,096 unpacking tar archive at: fx-team-6c24ecacc1a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:39.327668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:39.328106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:39.339680) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:39.340262) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:39.340917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-11 22:35:39.341403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:35:39 INFO - MultiFileLogger online at 20151211 22:35:39 in /builds/slave/test 22:35:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:35:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:35:39 INFO - {'append_to_log': False, 22:35:39 INFO - 'base_work_dir': '/builds/slave/test', 22:35:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:35:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:35:39 INFO - 'branch': 'Fx-Team-Non-PGO', 22:35:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:35:39 INFO - 'config_files': ('talos/linux_config.py',), 22:35:39 INFO - 'default_actions': ('clobber', 22:35:39 INFO - 'read-buildbot-config', 22:35:39 INFO - 'download-and-extract', 22:35:39 INFO - 'populate-webroot', 22:35:39 INFO - 'create-virtualenv', 22:35:39 INFO - 'install', 22:35:39 INFO - 'run-tests'), 22:35:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:35:39 INFO - 'download_minidump_stackwalk': True, 22:35:39 INFO - 'download_symbols': 'ondemand', 22:35:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:35:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:35:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:35:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:35:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:35:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:35:39 INFO - 'installer_path': 'installer.exe', 22:35:39 INFO - 'log_level': 'info', 22:35:39 INFO - 'log_name': 'talos', 22:35:39 INFO - 'log_to_console': True, 22:35:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:35:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:35:39 INFO - 'opt_config_files': (), 22:35:39 INFO - 'pip_index': False, 22:35:39 INFO - 'sps_profile': False, 22:35:39 INFO - 'sps_profile_interval': 0, 22:35:39 INFO - 'suite': 'dromaeojs-e10s', 22:35:39 INFO - 'system_bits': '64', 22:35:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:35:39 INFO - 'title': 'talos-linux64-ix-001', 22:35:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:35:39 INFO - 'use_talos_json': True, 22:35:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:35:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:35:39 INFO - 'work_dir': 'build'} 22:35:39 INFO - ##### 22:35:39 INFO - ##### Running clobber step. 22:35:39 INFO - ##### 22:35:39 INFO - Running pre-action listener: _resource_record_pre_action 22:35:39 INFO - Running main action method: clobber 22:35:39 INFO - rmtree: /builds/slave/test/build 22:35:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:35:44 INFO - Running post-action listener: _resource_record_post_action 22:35:44 INFO - ##### 22:35:44 INFO - ##### Running read-buildbot-config step. 22:35:44 INFO - ##### 22:35:44 INFO - Running pre-action listener: _resource_record_pre_action 22:35:44 INFO - Running main action method: read_buildbot_config 22:35:44 INFO - Using buildbot properties: 22:35:44 INFO - { 22:35:44 INFO - "properties": { 22:35:44 INFO - "buildnumber": 815, 22:35:44 INFO - "product": "firefox", 22:35:44 INFO - "script_repo_revision": "production", 22:35:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:35:44 INFO - "repository": "", 22:35:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:35:44 INFO - "buildid": "20151211213131", 22:35:44 INFO - "slavename": "talos-linux64-ix-001", 22:35:44 INFO - "pgo_build": "False", 22:35:44 INFO - "basedir": "/builds/slave/test", 22:35:44 INFO - "project": "", 22:35:44 INFO - "platform": "ubuntu64_hw", 22:35:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:35:44 INFO - "slavebuilddir": "test", 22:35:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:35:44 INFO - "branch": "fx-team", 22:35:44 INFO - "repo_path": "integration/fx-team", 22:35:44 INFO - "stage_platform": "linux64", 22:35:44 INFO - "builduid": "9d34c61704e44a82b3990521515adf3a", 22:35:44 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:44 INFO - }, 22:35:44 INFO - "sourcestamp": { 22:35:44 INFO - "repository": "", 22:35:44 INFO - "hasPatch": false, 22:35:44 INFO - "project": "", 22:35:44 INFO - "branch": "fx-team-linux64-talos", 22:35:44 INFO - "changes": [ 22:35:44 INFO - { 22:35:44 INFO - "category": null, 22:35:44 INFO - "files": [ 22:35:44 INFO - { 22:35:44 INFO - "url": null, 22:35:44 INFO - "name": "https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:35:44 INFO - } 22:35:44 INFO - ], 22:35:44 INFO - "repository": "", 22:35:44 INFO - "rev": "6c24ecacc1a9c5e9c054c074269f808d587ee29c", 22:35:44 INFO - "who": "philringnalda@gmail.com", 22:35:44 INFO - "when": 1449902117, 22:35:44 INFO - "number": 7354654, 22:35:44 INFO - "comments": "Merge m-c to f-t", 22:35:44 INFO - "project": "", 22:35:44 INFO - "at": "Fri 11 Dec 2015 22:35:17", 22:35:44 INFO - "branch": "fx-team-linux64-talos", 22:35:44 INFO - "revlink": "", 22:35:44 INFO - "properties": [ 22:35:44 INFO - [ 22:35:44 INFO - "buildid", 22:35:44 INFO - "20151211213131", 22:35:44 INFO - "Change" 22:35:44 INFO - ], 22:35:44 INFO - [ 22:35:44 INFO - "builduid", 22:35:44 INFO - "9d34c61704e44a82b3990521515adf3a", 22:35:44 INFO - "Change" 22:35:44 INFO - ], 22:35:44 INFO - [ 22:35:44 INFO - "pgo_build", 22:35:44 INFO - "False", 22:35:44 INFO - "Change" 22:35:44 INFO - ] 22:35:44 INFO - ], 22:35:44 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:44 INFO - } 22:35:44 INFO - ], 22:35:44 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:44 INFO - } 22:35:44 INFO - } 22:35:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:35:44 INFO - Running post-action listener: _resource_record_post_action 22:35:44 INFO - ##### 22:35:44 INFO - ##### Running download-and-extract step. 22:35:44 INFO - ##### 22:35:44 INFO - Running pre-action listener: _resource_record_pre_action 22:35:44 INFO - Running main action method: download_and_extract 22:35:44 INFO - mkdir: /builds/slave/test/build/tests 22:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:44 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json 22:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json 22:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:35:45 INFO - Downloaded 1302 bytes. 22:35:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:35:45 INFO - Using the following test package requirements: 22:35:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:35:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:35:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'jsshell-linux-x86_64.zip'], 22:35:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:35:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:35:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:35:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:35:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:35:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:35:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:35:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:35:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:35: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')]} 22:35:45 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:35:48 INFO - Downloaded 21869874 bytes. 22:35:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:35:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:35:49 INFO - Return code: 0 22:35:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:49 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:35:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:35:52 INFO - Downloaded 21869874 bytes. 22:35:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:35:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:35:54 INFO - Return code: 0 22:35:54 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')]} 22:35:54 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:35:55 INFO - Downloaded 11132038 bytes. 22:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:35:55 INFO - Return code: 0 22:35:55 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')]} 22:35:55 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:35:56 INFO - Downloaded 57736563 bytes. 22:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:35:56 INFO - mkdir: /builds/slave/test/properties 22:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:35:56 INFO - Contents: 22:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:35:56 INFO - Running post-action listener: _resource_record_post_action 22:35:56 INFO - Running post-action listener: set_extra_try_arguments 22:35:56 INFO - ##### 22:35:56 INFO - ##### Running populate-webroot step. 22:35:56 INFO - ##### 22:35:56 INFO - Running pre-action listener: _resource_record_pre_action 22:35:56 INFO - Running main action method: populate_webroot 22:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:35:56 INFO - '--tppagecycles', 22:35:56 INFO - '7'], 22:35:56 INFO - 'tests': ['tsvgm']}}, 22:35:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:35:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:35:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:35:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'tests': ['damp', 'tps']}, 22:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['damp', 'tps']}, 22:35:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:35:56 INFO - 'other': {'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'other_l64': {'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'other_nol64': {'tests': ['a11yr', 22:35:56 INFO - 'ts_paint', 22:35:56 INFO - 'tpaint', 22:35:56 INFO - 'sessionrestore', 22:35:56 INFO - 'sessionrestore_no_auto_restore']}, 22:35:56 INFO - 'svgr': {'tests': ['tsvgx', 22:35:56 INFO - 'tsvgr_opacity', 22:35:56 INFO - 'tart', 22:35:56 INFO - 'tscrollx', 22:35:56 INFO - 'cart']}, 22:35:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['tsvgx', 22:35:56 INFO - 'tsvgr_opacity', 22:35:56 INFO - 'tart', 22:35:56 INFO - 'tscrollx', 22:35:56 INFO - 'cart']}, 22:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'tests': ['tp5o']}, 22:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'talos_options': ['--e10s'], 22:35:56 INFO - 'tests': ['tp5o']}, 22:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'talos_options': ['--xperf_path', 22:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:56 INFO - 'tests': ['tp5n']}, 22:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:56 INFO - 'talos_options': ['--e10s', 22:35:56 INFO - '--xperf_path', 22:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:56 INFO - 'tests': ['tp5n']}}, 22:35:56 INFO - 'talos.zip': {'path': '', 22:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:35:56 INFO - Running post-action listener: _resource_record_post_action 22:35:56 INFO - ##### 22:35:56 INFO - ##### Running create-virtualenv step. 22:35:56 INFO - ##### 22:35:56 INFO - Running pre-action listener: _resource_record_pre_action 22:35:56 INFO - Running main action method: create_virtualenv 22:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:35:56 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 22:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:35:56 INFO - Using real prefix '/usr' 22:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:35:59 INFO - Installing pip.................done. 22:35:59 INFO - Return code: 0 22:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:35: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')]} 22:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35: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')]} 22:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:35:59 INFO - Using env: {'DISPLAY': ':0', 22:35:59 INFO - 'HOME': '/home/cltbld', 22:35:59 INFO - 'LANG': 'en_US.UTF-8', 22:35:59 INFO - 'LANGUAGE': 'en_US:en', 22:35:59 INFO - 'LOGNAME': 'cltbld', 22:35:59 INFO - 'MAIL': '/var/mail/cltbld', 22:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:59 INFO - 'MOZ_NO_REMOTE': '1', 22:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:59 INFO - 'NO_EM_RESTART': '1', 22:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:59 INFO - 'PWD': '/builds/slave/test', 22:35:59 INFO - 'SHELL': '/bin/bash', 22:35:59 INFO - 'SHLVL': '1', 22:35:59 INFO - 'TERM': 'linux', 22:35:59 INFO - 'TMOUT': '86400', 22:35:59 INFO - 'USER': 'cltbld', 22:35:59 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:59 INFO - '_': '/tools/buildbot/bin/python'} 22:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:00 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 22:36:00 INFO - Cleaning up... 22:36:00 INFO - Return code: 0 22:36:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:00 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:00 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 22:36:00 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 22:36:00 INFO - Using env: {'DISPLAY': ':0', 22:36:00 INFO - 'HOME': '/home/cltbld', 22:36:00 INFO - 'LANG': 'en_US.UTF-8', 22:36:00 INFO - 'LANGUAGE': 'en_US:en', 22:36:00 INFO - 'LOGNAME': 'cltbld', 22:36:00 INFO - 'MAIL': '/var/mail/cltbld', 22:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:00 INFO - 'MOZ_NO_REMOTE': '1', 22:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:00 INFO - 'NO_EM_RESTART': '1', 22:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:00 INFO - 'PWD': '/builds/slave/test', 22:36:00 INFO - 'SHELL': '/bin/bash', 22:36:00 INFO - 'SHLVL': '1', 22:36:00 INFO - 'TERM': 'linux', 22:36:00 INFO - 'TMOUT': '86400', 22:36:00 INFO - 'USER': 'cltbld', 22:36:00 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:00 INFO - '_': '/tools/buildbot/bin/python'} 22:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:00 INFO - Downloading/unpacking psutil>=0.7.1 22:36:00 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 22:36:00 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 22:36:00 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 22:36:00 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 22:36:00 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 22:36:00 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 22:36:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:02 INFO - Installing collected packages: psutil 22:36:02 INFO - Running setup.py install for psutil 22:36:02 INFO - building 'psutil._psutil_linux' extension 22:36:02 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 22:36:03 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 22:36:03 INFO - building 'psutil._psutil_posix' extension 22:36:03 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 22:36:03 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 22:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:04 INFO - Successfully installed psutil 22:36:04 INFO - Cleaning up... 22:36:04 INFO - Return code: 0 22:36:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:36: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')]} 22:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36: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')]} 22:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:04 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:04 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 22:36:04 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 22:36:04 INFO - Using env: {'DISPLAY': ':0', 22:36:04 INFO - 'HOME': '/home/cltbld', 22:36:04 INFO - 'LANG': 'en_US.UTF-8', 22:36:04 INFO - 'LANGUAGE': 'en_US:en', 22:36:04 INFO - 'LOGNAME': 'cltbld', 22:36:04 INFO - 'MAIL': '/var/mail/cltbld', 22:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:04 INFO - 'MOZ_NO_REMOTE': '1', 22:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:04 INFO - 'NO_EM_RESTART': '1', 22:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:04 INFO - 'PWD': '/builds/slave/test', 22:36:04 INFO - 'SHELL': '/bin/bash', 22:36:04 INFO - 'SHLVL': '1', 22:36:04 INFO - 'TERM': 'linux', 22:36:04 INFO - 'TMOUT': '86400', 22:36:04 INFO - 'USER': 'cltbld', 22:36:04 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:04 INFO - '_': '/tools/buildbot/bin/python'} 22:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:36:06 INFO - Installing collected packages: mozsystemmonitor 22:36:06 INFO - Running setup.py install for mozsystemmonitor 22:36:06 INFO - Successfully installed mozsystemmonitor 22:36:06 INFO - Cleaning up... 22:36:06 INFO - Return code: 0 22:36:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:36: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')]} 22:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36: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')]} 22:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:06 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:06 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 22:36:06 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 22:36:06 INFO - Using env: {'DISPLAY': ':0', 22:36:06 INFO - 'HOME': '/home/cltbld', 22:36:06 INFO - 'LANG': 'en_US.UTF-8', 22:36:06 INFO - 'LANGUAGE': 'en_US:en', 22:36:06 INFO - 'LOGNAME': 'cltbld', 22:36:06 INFO - 'MAIL': '/var/mail/cltbld', 22:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:06 INFO - 'MOZ_NO_REMOTE': '1', 22:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:06 INFO - 'NO_EM_RESTART': '1', 22:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:06 INFO - 'PWD': '/builds/slave/test', 22:36:06 INFO - 'SHELL': '/bin/bash', 22:36:06 INFO - 'SHLVL': '1', 22:36:06 INFO - 'TERM': 'linux', 22:36:06 INFO - 'TMOUT': '86400', 22:36:06 INFO - 'USER': 'cltbld', 22:36:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:06 INFO - '_': '/tools/buildbot/bin/python'} 22:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:06 INFO - Downloading/unpacking blobuploader==1.2.4 22:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:08 INFO - Downloading blobuploader-1.2.4.tar.gz 22:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:36:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:36:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 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 22:36:08 INFO - Downloading docopt-0.6.1.tar.gz 22:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:36:08 INFO - Installing collected packages: blobuploader, requests, docopt 22:36:08 INFO - Running setup.py install for blobuploader 22:36:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:36:08 INFO - Running setup.py install for requests 22:36:09 INFO - Running setup.py install for docopt 22:36:09 INFO - Successfully installed blobuploader requests docopt 22:36:09 INFO - Cleaning up... 22:36:09 INFO - Return code: 0 22:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:09 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')]} 22:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:09 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')]} 22:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:09 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:09 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 22:36:09 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 22:36:09 INFO - Using env: {'DISPLAY': ':0', 22:36:09 INFO - 'HOME': '/home/cltbld', 22:36:09 INFO - 'LANG': 'en_US.UTF-8', 22:36:09 INFO - 'LANGUAGE': 'en_US:en', 22:36:09 INFO - 'LOGNAME': 'cltbld', 22:36:09 INFO - 'MAIL': '/var/mail/cltbld', 22:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:09 INFO - 'MOZ_NO_REMOTE': '1', 22:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:09 INFO - 'NO_EM_RESTART': '1', 22:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:09 INFO - 'PWD': '/builds/slave/test', 22:36:09 INFO - 'SHELL': '/bin/bash', 22:36:09 INFO - 'SHLVL': '1', 22:36:09 INFO - 'TERM': 'linux', 22:36:09 INFO - 'TMOUT': '86400', 22:36:09 INFO - 'USER': 'cltbld', 22:36:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:09 INFO - '_': '/tools/buildbot/bin/python'} 22:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:09 INFO - Running setup.py (path:/tmp/pip-1doThK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:09 INFO - Running setup.py (path:/tmp/pip-eQLRSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:09 INFO - Running setup.py (path:/tmp/pip-EcKD5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:09 INFO - Running setup.py (path:/tmp/pip-LQf5Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:09 INFO - Running setup.py (path:/tmp/pip-eTbePl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:09 INFO - Running setup.py (path:/tmp/pip-Z6ril_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:10 INFO - Running setup.py (path:/tmp/pip-qGMxEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:10 INFO - Running setup.py (path:/tmp/pip-Zc17To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:10 INFO - Running setup.py (path:/tmp/pip-u4BA9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:10 INFO - Running setup.py (path:/tmp/pip-a6B3tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:10 INFO - Running setup.py (path:/tmp/pip-wKtFM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:10 INFO - Running setup.py (path:/tmp/pip-BqETiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:10 INFO - Running setup.py (path:/tmp/pip-CAIZOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:10 INFO - Running setup.py (path:/tmp/pip-lXDtqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:10 INFO - Running setup.py (path:/tmp/pip-3FIEMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:10 INFO - Running setup.py (path:/tmp/pip-TbC4se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:10 INFO - Running setup.py (path:/tmp/pip-yv0b_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:36:10 INFO - Running setup.py install for manifestparser 22:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:36:10 INFO - Running setup.py install for mozcrash 22:36:10 INFO - Running setup.py install for mozdebug 22:36:11 INFO - Running setup.py install for mozdevice 22:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for mozfile 22:36:11 INFO - Running setup.py install for mozhttpd 22:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for mozinfo 22:36:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for mozInstall 22:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for mozleak 22:36:11 INFO - Running setup.py install for mozlog 22:36:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for moznetwork 22:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:36:11 INFO - Running setup.py install for mozprocess 22:36:12 INFO - Running setup.py install for mozprofile 22:36:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:36:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:36:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:36:12 INFO - Running setup.py install for mozrunner 22:36:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:36:12 INFO - Running setup.py install for mozscreenshot 22:36:12 INFO - Running setup.py install for moztest 22:36:12 INFO - Running setup.py install for mozversion 22:36:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:36:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:36:12 INFO - Cleaning up... 22:36:12 INFO - Return code: 0 22:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:12 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:12 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 22:36:12 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 22:36:12 INFO - Using env: {'DISPLAY': ':0', 22:36:12 INFO - 'HOME': '/home/cltbld', 22:36:12 INFO - 'LANG': 'en_US.UTF-8', 22:36:12 INFO - 'LANGUAGE': 'en_US:en', 22:36:12 INFO - 'LOGNAME': 'cltbld', 22:36:12 INFO - 'MAIL': '/var/mail/cltbld', 22:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:12 INFO - 'MOZ_NO_REMOTE': '1', 22:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:12 INFO - 'NO_EM_RESTART': '1', 22:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:12 INFO - 'PWD': '/builds/slave/test', 22:36:12 INFO - 'SHELL': '/bin/bash', 22:36:12 INFO - 'SHLVL': '1', 22:36:12 INFO - 'TERM': 'linux', 22:36:12 INFO - 'TMOUT': '86400', 22:36:12 INFO - 'USER': 'cltbld', 22:36:12 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:12 INFO - '_': '/tools/buildbot/bin/python'} 22:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:12 INFO - Running setup.py (path:/tmp/pip-3WSIsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:12 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)) 22:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:12 INFO - Running setup.py (path:/tmp/pip-Orh3QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:12 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)) 22:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:12 INFO - Running setup.py (path:/tmp/pip-1jhkFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:12 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)) 22:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:13 INFO - Running setup.py (path:/tmp/pip-ZUQVf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:13 INFO - Running setup.py (path:/tmp/pip-HdJBge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:13 INFO - Running setup.py (path:/tmp/pip-3TNdVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:13 INFO - Running setup.py (path:/tmp/pip-uH7rJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:13 INFO - Running setup.py (path:/tmp/pip-ZuNcRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:13 INFO - Running setup.py (path:/tmp/pip-jPanOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:13 INFO - Running setup.py (path:/tmp/pip-GFdXAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:13 INFO - Running setup.py (path:/tmp/pip-JTiYhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:13 INFO - Running setup.py (path:/tmp/pip-LuWVEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:13 INFO - Running setup.py (path:/tmp/pip-SXUh7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:13 INFO - Running setup.py (path:/tmp/pip-UKQnve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:13 INFO - Running setup.py (path:/tmp/pip-Hcr7VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:13 INFO - Running setup.py (path:/tmp/pip-Te6vZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:13 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)) 22:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:13 INFO - Running setup.py (path:/tmp/pip-cTbkqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:14 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)) 22:36:14 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)) 22:36:14 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)) 22:36:14 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)) 22:36:14 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)) 22:36:14 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)) 22:36:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:36:14 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 22:36:14 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 22:36:14 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 22:36:14 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 22:36:14 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 22:36:14 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 22:36:15 INFO - Downloading blessings-1.5.1.tar.gz 22:36:15 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 22:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:36:15 INFO - Installing collected packages: blessings 22:36:15 INFO - Running setup.py install for blessings 22:36:16 INFO - Successfully installed blessings 22:36:16 INFO - Cleaning up... 22:36:16 INFO - Return code: 0 22:36:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:36:16 INFO - Reading from file tmpfile_stdout 22:36:16 INFO - Current package versions: 22:36:16 INFO - argparse == 1.2.1 22:36:16 INFO - blessings == 1.5.1 22:36:16 INFO - blobuploader == 1.2.4 22:36:16 INFO - docopt == 0.6.1 22:36:16 INFO - manifestparser == 1.1 22:36:16 INFO - mozInstall == 1.12 22:36:16 INFO - mozcrash == 0.16 22:36:16 INFO - mozdebug == 0.1 22:36:16 INFO - mozdevice == 0.47 22:36:16 INFO - mozfile == 1.2 22:36:16 INFO - mozhttpd == 0.7 22:36:16 INFO - mozinfo == 0.9 22:36:16 INFO - mozleak == 0.1 22:36:16 INFO - mozlog == 3.1 22:36:16 INFO - moznetwork == 0.27 22:36:16 INFO - mozprocess == 0.22 22:36:16 INFO - mozprofile == 0.27 22:36:16 INFO - mozrunner == 6.11 22:36:16 INFO - mozscreenshot == 0.1 22:36:16 INFO - mozsystemmonitor == 0.0 22:36:16 INFO - moztest == 0.7 22:36:16 INFO - mozversion == 1.4 22:36:16 INFO - psutil == 3.1.1 22:36:16 INFO - requests == 1.2.3 22:36:16 INFO - wsgiref == 0.1.2 22:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:16 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:16 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 22:36:16 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 22:36:16 INFO - Using env: {'DISPLAY': ':0', 22:36:16 INFO - 'HOME': '/home/cltbld', 22:36:16 INFO - 'LANG': 'en_US.UTF-8', 22:36:16 INFO - 'LANGUAGE': 'en_US:en', 22:36:16 INFO - 'LOGNAME': 'cltbld', 22:36:16 INFO - 'MAIL': '/var/mail/cltbld', 22:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:16 INFO - 'MOZ_NO_REMOTE': '1', 22:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:16 INFO - 'NO_EM_RESTART': '1', 22:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:16 INFO - 'PWD': '/builds/slave/test', 22:36:16 INFO - 'SHELL': '/bin/bash', 22:36:16 INFO - 'SHLVL': '1', 22:36:16 INFO - 'TERM': 'linux', 22:36:16 INFO - 'TMOUT': '86400', 22:36:16 INFO - 'USER': 'cltbld', 22:36:16 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:16 INFO - '_': '/tools/buildbot/bin/python'} 22:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 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)) 22:36:16 INFO - Cleaning up... 22:36:16 INFO - Return code: 0 22:36:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:16 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:16 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 22:36:16 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 22:36:16 INFO - Using env: {'DISPLAY': ':0', 22:36:16 INFO - 'HOME': '/home/cltbld', 22:36:16 INFO - 'LANG': 'en_US.UTF-8', 22:36:16 INFO - 'LANGUAGE': 'en_US:en', 22:36:16 INFO - 'LOGNAME': 'cltbld', 22:36:16 INFO - 'MAIL': '/var/mail/cltbld', 22:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:16 INFO - 'MOZ_NO_REMOTE': '1', 22:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:16 INFO - 'NO_EM_RESTART': '1', 22:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:16 INFO - 'PWD': '/builds/slave/test', 22:36:16 INFO - 'SHELL': '/bin/bash', 22:36:16 INFO - 'SHLVL': '1', 22:36:16 INFO - 'TERM': 'linux', 22:36:16 INFO - 'TMOUT': '86400', 22:36:16 INFO - 'USER': 'cltbld', 22:36:16 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:16 INFO - '_': '/tools/buildbot/bin/python'} 22:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:16 INFO - Downloading/unpacking jsonschema 22:36:16 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 22:36:16 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 22:36:16 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 22:36:16 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 22:36:16 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 22:36:16 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 22:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:36:18 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 22:36:18 INFO - Downloading/unpacking functools32 (from jsonschema) 22:36:18 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 22:36:18 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 22:36:18 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 22:36:18 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 22:36:18 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 22:36:18 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 22:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 22:36:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:36:18 INFO - warning: no files found matching '*.txt' 22:36:18 INFO - no previously-included directories found matching 'build' 22:36:18 INFO - no previously-included directories found matching 'dist' 22:36:18 INFO - no previously-included directories found matching '.git*' 22:36:18 INFO - Installing collected packages: jsonschema, functools32 22:36:18 INFO - Running setup.py install for functools32 22:36:18 INFO - warning: no files found matching '*.txt' 22:36:18 INFO - no previously-included directories found matching 'build' 22:36:18 INFO - no previously-included directories found matching 'dist' 22:36:18 INFO - no previously-included directories found matching '.git*' 22:36:18 INFO - Successfully installed jsonschema functools32 22:36:18 INFO - Cleaning up... 22:36:18 INFO - Return code: 0 22:36:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:36: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')]} 22:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36: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')]} 22:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:18 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 0x7fdfe15faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', '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 22:36:18 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 22:36:18 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 22:36:18 INFO - Using env: {'DISPLAY': ':0', 22:36:18 INFO - 'HOME': '/home/cltbld', 22:36:18 INFO - 'LANG': 'en_US.UTF-8', 22:36:18 INFO - 'LANGUAGE': 'en_US:en', 22:36:18 INFO - 'LOGNAME': 'cltbld', 22:36:18 INFO - 'MAIL': '/var/mail/cltbld', 22:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:18 INFO - 'MOZ_NO_REMOTE': '1', 22:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:18 INFO - 'NO_EM_RESTART': '1', 22:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:18 INFO - 'PWD': '/builds/slave/test', 22:36:18 INFO - 'SHELL': '/bin/bash', 22:36:18 INFO - 'SHLVL': '1', 22:36:18 INFO - 'TERM': 'linux', 22:36:18 INFO - 'TMOUT': '86400', 22:36:18 INFO - 'USER': 'cltbld', 22:36:18 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:18 INFO - '_': '/tools/buildbot/bin/python'} 22:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:19 INFO - Downloading/unpacking flake8 22:36:19 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 22:36:19 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 22:36:19 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 22:36:19 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 22:36:19 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 22:36:19 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 22:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:36:20 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 22:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:36:20 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 22:36:20 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 22:36:20 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 22:36:20 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 22:36:20 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 22:36:20 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 22:36:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:36:21 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 22:36:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 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 22:36:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:21 INFO - no previously-included directories found matching 'docs/_build' 22:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:36:21 INFO - Running setup.py install for pep8 22:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:21 INFO - no previously-included directories found matching 'docs/_build' 22:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:36:21 INFO - Cleaning up... 22:36:21 INFO - Return code: 0 22:36:21 INFO - Running post-action listener: _resource_record_post_action 22:36:21 INFO - Running post-action listener: _start_resource_monitoring 22:36:21 INFO - Starting resource monitoring. 22:36:21 INFO - ##### 22:36:21 INFO - ##### Running install step. 22:36:21 INFO - ##### 22:36:21 INFO - Running pre-action listener: _resource_record_pre_action 22:36:21 INFO - Running main action method: install 22:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:36:21 INFO - Reading from file tmpfile_stdout 22:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:36:22 INFO - Reading from file tmpfile_stdout 22:36:22 INFO - Output received: 22:36:22 INFO - Usage: mozinstall [options] installer 22:36:22 INFO - Options: 22:36:22 INFO - -h, --help show this help message and exit 22:36:22 INFO - -d DEST, --destination=DEST 22:36:22 INFO - Directory to install application into. [default: 22:36:22 INFO - "/builds/slave/test"] 22:36:22 INFO - --app=APP Application being installed. [default: firefox] 22:36:22 INFO - mkdir: /builds/slave/test/build/application 22:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:36:36 INFO - Reading from file tmpfile_stdout 22:36:36 INFO - Output received: 22:36:36 INFO - /builds/slave/test/build/application/firefox/firefox 22:36:36 INFO - Running post-action listener: _resource_record_post_action 22:36:36 INFO - ##### 22:36:36 INFO - ##### Running run-tests step. 22:36:36 INFO - ##### 22:36:36 INFO - Running pre-action listener: _resource_record_pre_action 22:36:36 INFO - Running main action method: run_tests 22:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:36:36 INFO - Python 2.7.3 22:36:36 INFO - Return code: 0 22:36:36 INFO - grabbing minidump binary from tooltool 22:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:36 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 0x2a480b0>, '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 0x2a48fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:36:36 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 22:36:36 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 22:36:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:36:36 INFO - Return code: 0 22:36:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:36:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:36:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:36:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:36:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:36:37 INFO - Return code: 0 22:36:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 22:36:37 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 22:36:37 INFO - Using env: {'DISPLAY': ':0', 22:36:37 INFO - 'HOME': '/home/cltbld', 22:36:37 INFO - 'LANG': 'en_US.UTF-8', 22:36:37 INFO - 'LANGUAGE': 'en_US:en', 22:36:37 INFO - 'LOGNAME': 'cltbld', 22:36:37 INFO - 'MAIL': '/var/mail/cltbld', 22:36:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:36:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:37 INFO - 'MOZ_NO_REMOTE': '1', 22:36:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:37 INFO - 'NO_EM_RESTART': '1', 22:36:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:37 INFO - 'PWD': '/builds/slave/test', 22:36:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:36:37 INFO - 'SHELL': '/bin/bash', 22:36:37 INFO - 'SHLVL': '1', 22:36:37 INFO - 'TERM': 'linux', 22:36:37 INFO - 'TMOUT': '86400', 22:36:37 INFO - 'USER': 'cltbld', 22:36:37 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643', 22:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:37 INFO - '_': '/tools/buildbot/bin/python'} 22:36:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 22:36:38 INFO - mozversion INFO | application_buildid: 20151211213131 22:36:38 INFO - mozversion INFO | application_changeset: 6c24ecacc1a9c5e9c054c074269f808d587ee29c 22:36:38 INFO - mozversion INFO | application_display_name: Nightly 22:36:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:36:38 INFO - mozversion INFO | application_name: Firefox 22:36:38 INFO - mozversion INFO | application_remotingname: firefox 22:36:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:36:38 INFO - mozversion INFO | application_vendor: Mozilla 22:36:38 INFO - mozversion INFO | application_version: 45.0a1 22:36:38 INFO - mozversion INFO | platform_buildid: 20151211213131 22:36:38 INFO - mozversion INFO | platform_changeset: 6c24ecacc1a9c5e9c054c074269f808d587ee29c 22:36:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:36:38 INFO - mozversion INFO | platform_version: 45.0a1 22:36:38 INFO - 2015-12-11 22:36:38,194 DEBUG : using testdate: 1449902198 22:36:38 INFO - 2015-12-11 22:36:38,194 DEBUG : actual date: 1449902198 22:36:38 INFO - 2015-12-11 22:36:38,242 INFO : starting webserver on 'localhost:33368' 22:36:38 INFO - 2015-12-11 22:36:38,243 INFO : Starting test suite talos-linux64-ix-001.e 22:36:38 INFO - 2015-12-11 22:36:38,243 INFO : Starting test dromaeo_css 22:36:38 INFO - 2015-12-11 22:36:38,243 DEBUG : operating with platform_type : linux_ 22:36:38 INFO - 2015-12-11 22:36:38,244 INFO : Initialising browser for dromaeo_css test... 22:36:38 INFO - 2015-12-11 22:36:38,271 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogFjWH/profile http://localhost:33368/getInfo.html 22:36:44 INFO - 2015-12-11 22:36:44,928 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:44 INFO - 2015-12-11 22:36:44,928 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:44 INFO - 2015-12-11 22:36:44,929 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:36:44 INFO - 2015-12-11 22:36:44,929 DEBUG : BROWSER_OUTPUT: __metrics 22:36:45 INFO - 2015-12-11 22:36:45,058 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] 22:36:45 INFO - 2015-12-11 22:36:45,972 INFO : Browser initialized. 22:36:45 INFO - 2015-12-11 22:36:45,972 INFO : Running cycle 1/1 for dromaeo_css test... 22:36:45 INFO - 2015-12-11 22:36:45,973 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogFjWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:36:57 INFO - 2015-12-11 22:36:57,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 142888960 22:36:57 INFO - 2015-12-11 22:36:57,995 DEBUG : BROWSER_OUTPUT: 22:37:47 INFO - 2015-12-11 22:37:47,626 DEBUG : BROWSER_OUTPUT: 1449902267624 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] 22:39:59 INFO - 2015-12-11 22:39:59,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33368/tests/dromaeo/cssquery-ext.html) 22:40:01 INFO - 2015-12-11 22:40:01,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 145281024 22:40:01 INFO - 2015-12-11 22:40:01,053 DEBUG : BROWSER_OUTPUT: 22:43:03 INFO - 2015-12-11 22:43:03,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-ext.html (next: http://localhost:33368/tests/dromaeo/cssquery-jquery.html) 22:43:03 INFO - 2015-12-11 22:43:03,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 145068032 22:43:03 INFO - 2015-12-11 22:43:03,761 DEBUG : BROWSER_OUTPUT: 22:46:05 INFO - 2015-12-11 22:46:05,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33368/tests/dromaeo/cssquery-mootools.html) 22:46:06 INFO - 2015-12-11 22:46:06,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 146927616 22:46:06 INFO - 2015-12-11 22:46:06,162 DEBUG : BROWSER_OUTPUT: 22:49:07 INFO - 2015-12-11 22:49:07,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33368/tests/dromaeo/cssquery-prototype.html) 22:49:08 INFO - 2015-12-11 22:49:08,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 143896576 22:49:08 INFO - 2015-12-11 22:49:08,553 DEBUG : BROWSER_OUTPUT: 22:52:11 INFO - 2015-12-11 22:52:11,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33368/tests/dromaeo/cssquery-yui.html) 22:52:11 INFO - 2015-12-11 22:52:11,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 144097280 22:52:11 INFO - 2015-12-11 22:52:11,816 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/dromaeo/cssquery-yui.html (next: http://localhost:33368/tests/dromaeo/cssquery-dojo.html) 22:55:14 INFO - 2015-12-11 22:55:14,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 146886656 22:55:14 INFO - 2015-12-11 22:55:14,530 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:55:14 INFO - 2015-12-11 22:55:14,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:55:14 INFO - 2015-12-11 22:55:14,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:55:14 INFO - 2015-12-11 22:55:14,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:55:14 INFO - 2015-12-11 22:55:14,535 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2678.611601317809;2719.2250208690525;2740.7259274072594;2754.4904192724334;2768.0173538393874;4596.770161491929;4760.071786001727;4808.735519546423;4824.831130910419;4826.734529600875;4707.4351077870615;4724.291356296557;4749.0264495778365;4755.667103302771;4758.928616070762;4353.477582690066;4371.169477799216;4419.9337009944875;4499.212637788391;4528.411306530146;4497.280435130379;4503.964088259702;4549.226631472641;4552.544745525437;4597.126545956275;4234.237837189305;4497.033137875373;4541.795619197128;4560.612347950411;4578.130155270488;4281.250781113293;4349.913001739979;4393.51671316155;4427.22523558376;4471.038726673748;4387.670924680661;4414.80133393998;4435.3125265583885;4437.134758722018;4469.463664360265;4539.954600454019;4644.814207431698;4669.789859456333;4681.578657920803;4690.742009189493;5070.138076527;5182.663126896778;5183.0670479314085;5185.040767457995;5229.398619158769;5162.457941916082;5210.088234558937;5223.347081614798;5243.239730239094;5254.92117618236;4634.791434385461;4745.83389581363;4784;4814.1334559779225;4840.806367745321;5332.413434522199;5339.41266460689;5354.357477102694;5378.381486129067;5381.78472861089;5115.820946266863;5116.976604679079;5122.334096567497;5125.9743701282005;5159.871003224875;4892.241702536113;4965.553100220997;4988.55103040728;4992.475790041994;5237.450067742909;5012.348394708664;5052.191649336089;5076.0863044652315;5092.083424983539;5124.692518448905;5087.694738315713;5094.898102037939;5111.974440127776;5116.641835071509;5150.459201783834;4116.300228961084;4157.064660451374;4283.87148385549;4292.720973136736;4321.438213032286;3665.248624032067;3724.795136267477;3741.56971948224;3761.1349389640536;3763.284975854579;4509.391232183613;4512.165249428866;4543.023250001265;4552.567506086983;4568.040711450566;4929.088118698052;5045.5459008689395;5074.771635276422;5239.083160446907;5278.261043453843;4531.68278220528;4539.682222244477;4553.385292985405;4560.293154561048;4607.7004994675235;4592.931106033412;4608;4611.239145541015;4611.2852507861335;4658.976705116453;4668.1363947669115;4785.665003449864;4787.952120478751;4888.682235654671;4938.259261110862;5207.3230480037355;5218.165093585008;5226.11156103471;5228.738563071755;5234.528892399702;4939.061578300111;4945.925811112908;4950.108980383421;4951.702897826142;4967.776450059684;4864.756762161807;4957.950420495749;5021.196608542616;5028.497150284942;5108.872278192926;5196.662216956037;5213.244079608511;5242.5281724644965;5246.790128394821;5255.763490642854;5076.82231121909;5077.695338279715;5080.288759573588;5089.491050895029;5109.489051094861;4793.664443488922;4897.8285759998225;4910.950890491193;4953.133201689762;5064.215046667772;4905.754712264444;4946.282788995647;4947.703137811743;4965.553100220997;4994.950050499594;5035.672681275705;5076.695398276115;5087.694738315713;5099.847004589868;5132.178851383761;4743.952560474351;4851.199552073868;4876.634252431011;4980.576650984707;5014.323066385991 22:55:14 INFO - 2015-12-11 22:55:14,538 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.9817440473518;564.5201578658139;567.1153001317945;574.6724367110747;577.1573502686078;35855.46216806747;36705.99999999996;36809.07977300569;36891.44662830056;36966;41282;41927;41959.370609440884;41977.37033944493;41988.79005604975;7950.483218590787;8177.79555511114;8183.345332373426;8190.959045204795;8193.057798353206;7910.169432209622;7962.800929976739;8027.919720802775;8033.879491807627;8035.879461808077;7984.760457186294;8044.959775201116;8060.596970151469;8091.676332946675;8102.270795628392;7980.481268717544;8065.39509536787;8069.031716194036;8085.757427277133;8106.432549721522;7948.364130869574;8057.6374063167295;8074.555899425529;8093.757187284391;8123;37269;37506.62493375059;37631;37646;37739;2958.482265603532;3073.2931425771976;3325.218573635194;3643.362411577963;3669.1194113412857;27742.583861242096;27967.300817479725;28231.57652635212;30547.38905221883;30820.2294942626;2956.8373739444323;2966.8961586344376;2995.5806187133817;3023.4104349651825;3038.60498135241;216414;217827;218709;218766;219662;52744.73627631837;53896.73051634717;57097;57634;58778.11832822426;57488.425115749145;57597.42402576005;57908;57989;58060;14632.975691701478;14651;14706;14817;14867.405303787944;10621.893781062245;10636.574537018432;10661.147108231324;10681.893181068246;10691;19548.902255488916;20050.398488045383;20089.799102008794;20108.698369524467;20218.19127234894;7805.960970195113;8090.150534193943;8099.716509922125;8101.797455063671;8181.181881811771;826.5908375354238;906.392716879679;1046.2414749306845;1067.9839802402971;1075.2097208551709;26359.47281054368;26424.603630945552;26635.46729065408;26717.732822671915;26808.731912681014;923.4274749655123;939.2157548446986;974.2254907348674;985.7732721474101;1088.4666513408372;13839;13893.930530347283;14053.367598458093;14174.14955102697;14194.645133871529;254543;261028;261871;262510;263078;46654.53345466502;47470.76264618655;47658.285125723145;47701;47701.284480732815;1199.5921386728555;1200.0759415250209;1200.6698158006443;1204.7108693913397;1354.3431435753848;25323.366915826515;25403.237902862944;25779;25829.741702582734;26018.73981260163;40710.79644601758;40736.3889541663;40989.38515922204;41052;41287.380689289086;242814;246083;246255;246829;246830;29637;43590.78204608957;44305.11389772122;44748;44971.32543011923;39657;40084;46283.76858115688;47180.7640961793;47381;33553.32893342168;33633.327333452704;34231.65768342285;34416.827915861264;34791;33600.15999600029;33647;33913.66086339105;34134.65865341414;34215.486767699;33613.83193084019;33947.66052339445;33947.83026084854;34197.48703769396;34283.657163429045;28979.275518112216;30656.846715766278;31117.377652447278;31246.21884452907;31405.371892562478;23989.76010239875;24046.27861164168;24100.75899240985;24132.155374561808;24199 22:55:14 INFO - 2015-12-11 22:55:14,538 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.80211872876265;332.220941891265;333.07239338442434;333.107272509674;336.1746911332676;14582;15085;15344.386224551019;16215.83784162158;16786.916065419657;14392.928035359835;14651.487197948074;15456.69086618267;15465.92267038666;15534.378624854991;4529.728216307016;4752.7861246244;4754.572088512034;4759.428868535781;4760.33355330254;4730.668853180278;4755.785989630458;4756.3816703828625;4758.571728544431;4760.809567617292;3498.142954976022;3607.801570913599;4687.343771871923;4715.528447155274;5275.868103297429;5330.200469929503;5390.676559406448;5392.838214853561;5396.298481197419;5409.323834520685;5014.674046187022;5116.923246151274;5122.33409656746;5206.609504287194;5217.113090774577;12193.085518586142;12246.142770006103;13944.790828137586;19062.33281835129;19198.424047278604;1809.4390738870993;1870.8035656256034;1893.280553389717;1901.4105627255456;1940.9708854367195;8468.110848360957;8910.732678019669;10508.684739457753;12704.364781760967;13004.479820807157;1762.8237176282398;1779.9377021804175;1794.6949018666858;1812.9274829006824;1821.298799962011;53336;56366.590835229035;56897;57174;57651.711741441446;9043.502607356659;9048.321375896834;9051.411658242194;9113.772155696028;9132.452052876848;10884.346939183675;10911.072558832588;10933.28933619328;11011.229213955106;11017.394043327695;6980.511364204558;7042.507024508338;7078.504504684623;7157.785266442015;7161.427085833121;7088.432925365958;7116.715331386687;7130.894711319754;7132.286771322826;7152.392046675986;3683.318586061587;3781.0736369589627;4162.708610397303;4243.448351714257;4258.914821703549;1584.294988730004;1595.2183430119157;1596.5290239379178;1617.3045590396243;1650.7358822588328;383.8925100971732;387.6666067182221;832.9875051874227;922.8707980882682;939.9295052871062;9700.116604710038;10163.136133428594;15293.617659558378;15976.600584985468;15995.920020399824;883.8409086364387;887.5429153985702;917.0508523677961;926.8285367207088;974.907383798538;8801.735947921572;8887.955560222157;9116.028951428436;9381.953090234505;9595.13643772064;450095;451644;469158;472781;474158;71474.64262678758;74143.62928185324;74868;75203.62398188084;75500.62249688717;1104.2987702808775;1111.2943281016612;1114.0808832712883;1115.3865374044406;1115.65414721435;14536.345864436338;14614.634634134232;14759.778603320745;14936.775948361;14973.925130374279;33914.830425847715;34024.14939626529;34853.82573087118;35243;35581;44861.102777943604;45350.54649453595;47724;47919.76040119777;48571.028579427504;8891.4665120093;9057.501837399006;9123.817523649357;9129.634814607341;9148.359614826899;10676.252662313564;12642.55751048709;15889.920550397173;15975;16071.11608861524;12975.480980760663;13544.255065971467;13557.118787278796;14150.363233654716;14157.575272741835;11347.262427942158;12072.33602151855;12577.119601627799;12961.15752476086;13213.801792973305;13385.263810490516;13461.326933653474;13551.457941682616;13738.175709457464;14289.142651440947;8554.31565474773;8723.302135828992;8803.899512560929;8819.559022048743;8858.778530536789;9320.440773553337;9452.480113593818;12330.81503777426;13083.215007099605;13391.86608133945 22:55:14 INFO - 2015-12-11 22:55:14,542 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1400.6428360768007;1465.699531596023;1578.928948197331;1605.2856478866909;1711.5806627376287;5754.424557544244;6041.365656606048;6621.304762999882;6946.305369463057;6956.6521673916295;6592.143021407211;6795.286494918037;6862.451003919687;6864.279250678669;6871.072405225293;2017.798220177985;2045.0388317490756;2059.639563076463;2061.7525896892394;2069.772325044244;2081.375587323804;2092.3618296419586;2106.3154474795674;2108.9367318980453;2133.1467413034834;2013.2249084102652;2041.8979051047463;2048.754149502062;2049.241780541202;2051.897405129745;2035.6641154209537;2061.3506745375234;2063.9896800515903;2064.349729835097;2064.9690254646193;2013.6476116679523;2033.2070492507933;2043.1112466077304;2055.4450298419342;2061.2167376396874;6836.897446538306;6970.651467426608;6971.930280697179;6981.3367730065565;6985.19670237924;4042;4112.856050038265;4131.5248746394245;4137.213929353413;4137.903455584273;2660.1088635307196;2676.6921803992595;2688.75801177893;2717.429339838636;2740.7122252163435;864.5633954852759;865.7705707987388;873.5763154869883;873.6592728835759;900.3337530227584;8950.910490895138;8974.326925480615;9031.593578288992;9063.13900179482;9069.863952040725;3686.4838922550866;3691.483192353073;3767.56672982605;3769.2838360711376;3782.319182547168;7867.6459559319965;7880.330171935335;7913.485623434458;7921.732522796325;7922.326602238874;4068.2880495913096;4069.348904175318;4071.3892916062237;4082.2243773682903;4090.1206240658403;3162.7469802415753;3249.7237734792334;3717.888463346104;3746.0822098586023;3754.08025033863;3385.25524384635;3388.508666243381;3402.897913062612;3432.3650124727005;3439.8280085995602;1038.5326603028668;1043.4209013997154;1044.3733759744246;1050.9421981791074;1054.3621109228807;991.9752006199902;1017.7353887989028;1019.9643012494527;1019.9847002294972;1054.5465449856636;6495.447886929569;6551.508636852255;6562.67186640666;6613.966930165318;6617.4706023518;416.82493352791903;417.36560428149045;418.35155508960986;423.1632441197085;424.45245633132913;5090;5127.4872512748425;5132.153194722829;5133.383993920679;5134.512221338967;7823.2567906048835;8032.839343213103;8048.5170889746805;8060.274575288252;8169.2647661710735;7950.284474397332;7969.561674107979;7993.400494962901;8006.199380062064;8010.19898010206;6518;6551.836204094936;6582.473402127914;6633.4693224541925;6687.264400915896;6613.371729685672;6663.36698013688;6664.700088496126;6674.699638516181;6691.330866913269;7369.557826530211;7485.1017877855;7542.698292068256;7591.430642701709;7663.118741344817;7538.09542854861;7629.198934112061;7669.309762121213;7688.077430708351;7728.26581474759;5393.541548968382;5514.669119852661;5887.234659494238;6161.199044124235;6238.251409830849;6491.058796474579;6491.545591808717;6493.318201588765;6496.350364963466;6520.347965203631;6000;6176.413240742122;6207.099970504342;6213.347598502273;6290.748370065146;6069.332373439007;6141.631502109888;6171.290301615371;6230.7507699693315;6282.623042617458;6127.632342059491;6171.290301615371;6179.5056395489155;6181.752729890754;6181.938180618136;5836.678982655825;5846.123081537803;5870.442307980735;5877.970610146922;5906.025505791668;5846.1815345852465;5911.290645122441;5920.644761314335;5922.496587789914;5928.8814223716145 22:55:14 INFO - 2015-12-11 22:55:14,543 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.84267338310696;303.99544006839886;304.8536702382855;306.87418158555;309.14829644329876;5550.2507161533185;5562.3047119110115;5714.114312281593;5720.914186287198;5722.971385143073;5559.8888022239535;5564.916526252109;5590.6239848064615;5600.5799565032685;5605.775768969246;4166.291730405823;4360.23695853226;4364.454443194601;4365.323374876899;4369.868903932879;4261.254280500915;4261.659067274626;4275.615194632483;4307.1170410066015;4316.654667626598;4237.110206856564;4237.258479766044;4239.3852891330735;4242.172776308621;4253.638440732541;4226.091390351058;4242.469691288589;4257.020885196423;4260.360945858146;4260.4248426462655;3689.1330537323706;3695.4826324314618;3700.0379901225606;3700.204456041937;3701.1857391373856;5280.9471905281225;5285.762140703678;5438.320209973754;5450.182472629098;5480.205370221335;4898.461169271377;4902.975485122587;4907.705537667715;4909.386326709161;4913.8771530711665;5926.940730592682;5936.643801371888;5939.465448109648;5952.0476723724;5958.165856780054;3938.72428929975;4004.0990777074926;4015.1768887378016;4015.6185162409815;4032.2741906457118;6159.38406159385;6250.624962502265;6254.312025677172;6260.248770147611;6260.373962603749;4145.606167414091;4147.688923330702;4151.14901445203;4152.501699795984;4156.649089046072;4167.708260421741;4202.138561594866;4202.579742025834;4215.072684009513;4222.218889505451;4711.340412342275;4842.564169224786;4863.148948933923;4869.123557759637;4880.536349046835;5889.911651325234;5896.997510423153;5911.733971971272;5918.585699001114;5933.881322373529;1483.391809358158;1493.6788590453104;1493.8954273200989;1494.2827442827504;1494.7757836324638;975.9560819763128;979.3487330924997;988.6737376665683;996.6312464388222;999.2705325112563;5184.222366644958;5185.507376799198;5193.039287731782;5204.505571970657;5206.687598744087;6126.203593532901;6128.387161283925;6128.540359473057;6145.508359331243;6164.4760195383;5154.098032844237;5170.508801663836;5186.870328241749;5197.974010129925;5210.348706411699;3221.4362486564755;3283.4254005548933;3337.916552086217;3344.6320904700465;3348.7321014318795;5708.343540492813;5742.16738572913;5805.854853628609;5837.211976383219;5866.882662346729;6396.712147953353;6441.710123044474;6442.5812322199845;6447.516436267299;6448.258450278278;5805.187273781674;5848.444397782204;5851.824445266649;5859.414058594107;5861.062230043172;6157.168782214344;6180.443760061616;6220.626762394271;6234.786650739104;6241.690574487287;5901.262342207224;6063.060225665029;6089.939100608937;6090.086487026982;6107.358727333566;5778.595498315078;5820.156077368673;5827.358990511125;5841.211436456024;5847.7368518417625;4113;4156.8129434174925;4160.479940007499;4169.207850508394;4169.728967617095;6016.458518733335;6199;6200.968995154995;6204.844878878064;6220.875582488416;5920.319163296103;5937.2578427696535;5944.1975333331175;5947.91078133837;5967.37342579023;5936.406359364029;5939.940600594112;5949.702514874326;5953.226080609493;5957.225560677258;5585.916211256753;5752.9137062943255;5810.041343178328;5811.506021988178;5815.912761308499;5965.254343207099;6003.039513677791;6013.067974463965;6024.216851809412;6026.427489388501;5814.447627475383;5848.444397782204;5855.560832937632;5860.062390017577;5874.676892770939 22:55:14 INFO - 2015-12-11 22:55:14,544 DEBUG : BROWSER_OUTPUT: |5;yui.html;645.4126744662358;680.2992917295188;721.1310371002942;782.6047845837853;788.5150632361098;11199.83200251996;11548.595799147031;11551.364674942875;11562.710932226699;11617.302961822297;11644.068474522039;11830.290182589051;11834.644960651194;11852.466639001244;11856.822147667792;617.9752809887599;623.6227082615021;780.8204113053987;805.3275514945028;814.9755507334789;790.5770412829138;804.4690504267155;805.7018903005896;806.7136166660839;807.0517142357736;841.8105926166594;843.7932706486889;844.2950136635916;844.3034496540379;844.4933040175907;828.1801016993134;831.2850948184556;832.8292699996487;834.3241974001048;844.8817165596821;626.495670984857;626.5864529410612;631.6999425273004;634.0046127579702;637.37537213531;11971.820422693667;11979;11991.28052316855;11991.400429978466;12030.27818330903;10607.310524815863;10708.25042247043;10740.838887416696;10806;10862.891371086345;8566.443181193203;8890.06654301302;8898;8938.597763100675;9192.770180745469;3235.5308480270464;3292.423825830494;3314.2708604107056;3355.312161006988;3381.8140002299865;39926.0018499537;40013.39979900304;40059.39910901368;40140.59859401398;40351;7651.4261430391825;7671.501352412187;7851.803704907309;7954.284114429729;8061.1938806118915;15511.5346539604;15573.766393504107;15580.987235829862;15644.765328520081;15739.44911928077;6041.24484439445;6250.656213908279;6299.023651334051;6408.391202835724;6417.26201486835;3496.947545786815;3593.4250519916686;3637.8726744563814;3645.671889529955;3659.835307411173;2638.129417292327;2648.9867550662507;2665;2676.2907829425217;2677.812553121302;449.97300161990387;452.3079688077247;458.30795498797056;468.6227586792597;469.58207195595946;429.4138500946186;539.8204575052941;556.5547561950505;563.4872266237704;609.9969500152471;7193.424526037905;7456.96271518639;7491.550506969599;7744.49660772048;7766.844663106706;460.4543615815203;478.85873667268237;488.68479830509835;497.6566169343142;612.5008118383503;3646.161382881952;3690.8892733218045;3734.7572407793405;4049.919001619951;4064.898377540585;49570.50429495731;50425.24362134571;50463.24305135426;50469.49530504721;50725;43767.56232437635;44462;44533.55466445294;44996.55003449989;45143.77428112838;41091.38362924558;41275.587244127775;41467;41596.37605435981;41815.37276940788;7733.458657893893;8123.878141827996;8218.260356567938;8246.876296855671;8348.123447038217;31642.36715265728;31864.522032169072;31897;31907.68092319047;32378.190545236557;36980.52077916853;37021.62978370182;39351.6064839348;40294.79852600718;40579.18841623092;9660.227181825578;9722.27082968766;10104.494775261355;10304;10461.633842815465;11087.41369732543;11170.609028683957;11513.712157196138;11767.937314908944;11856.466459009192;10871.29336593119;10950;11030.889691103308;11079.390633515233;11602.593909213138;10672.092872105957;10714;10879.23845330851;11140.33158010522;11171.664850054187;9301.953490232505;10477;10577.841332379867;10579.62971296001;10744.946275268574;9039.186473217442;9182.219511341344;9201.665758464851;9257.768555786159;9383.061693830563;8589.355798315277;8762;8800.16398442147;9000.414973026733;9010.50442225684 22:55:14 INFO - 2015-12-11 22:55:14,544 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,331 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903314532__endTimestamp 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:55:14 INFO - 2015-12-11 22:55:14,545 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,546 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4755.64 Median:4876.63 stddev:502.63 (10.3%) stddev-sans-first:477.03 22:55:14 INFO - 2015-12-11 22:55:14,546 DEBUG : BROWSER_OUTPUT: Values: 2678.6 2719.2 2740.7 2754.5 2768.0 4596.8 4760.1 4808.7 4824.8 4826.7 4707.4 4724.3 4749.0 4755.7 4758.9 4353.5 4371.2 4419.9 4499.2 4528.4 4497.3 4504.0 4549.2 4552.5 4597.1 4234.2 4497.0 4541.8 4560.6 4578.1 4281.3 4349.9 4393.5 4427.2 4471.0 4387.7 4414.8 4435.3 4437.1 4469.5 4540.0 4644.8 4669.8 4681.6 4690.7 5070.1 5182.7 5183.1 5185.0 5229.4 5162.5 5210.1 5223.3 5243.2 5254.9 4634.8 4745.8 4784.0 4814.1 4840.8 5332.4 5339.4 5354.4 5378.4 5381.8 5115.8 5117.0 5122.3 5126.0 5159.9 4892.2 4965.6 4988.6 4992.5 5237.5 5012.3 5052.2 5076.1 5092.1 5124.7 5087.7 5094.9 5112.0 5116.6 5150.5 4116.3 4157.1 4283.9 4292.7 4321.4 3665.2 3724.8 3741.6 3761.1 3763.3 4509.4 4512.2 4543.0 4552.6 4568.0 4929.1 5045.5 5074.8 5239.1 5278.3 4531.7 4539.7 4553.4 4560.3 4607.7 4592.9 4608.0 4611.2 4611.3 4659.0 4668.1 4785.7 4788.0 4888.7 4938.3 5207.3 5218.2 5226.1 5228.7 5234.5 4939.1 4945.9 4950.1 4951.7 4967.8 4864.8 4958.0 5021.2 5028.5 5108.9 5196.7 5213.2 5242.5 5246.8 5255.8 5076.8 5077.7 5080.3 5089.5 5109.5 4793.7 4897.8 4911.0 4953.1 5064.2 4905.8 4946.3 4947.7 4965.6 4995.0 5035.7 5076.7 5087.7 5099.8 5132.2 4744.0 4851.2 4876.6 4980.6 5014.3 22:55:14 INFO - 2015-12-11 22:55:14,547 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,547 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41235.68 Median:34350.24 stddev:62965.47 (183.3%) stddev-sans-first:63067.99 22:55:14 INFO - 2015-12-11 22:55:14,547 DEBUG : BROWSER_OUTPUT: Values: 546.0 564.5 567.1 574.7 577.2 35855.5 36706.0 36809.1 36891.4 36966.0 41282.0 41927.0 41959.4 41977.4 41988.8 7950.5 8177.8 8183.3 8191.0 8193.1 7910.2 7962.8 8027.9 8033.9 8035.9 7984.8 8045.0 8060.6 8091.7 8102.3 7980.5 8065.4 8069.0 8085.8 8106.4 7948.4 8057.6 8074.6 8093.8 8123.0 37269.0 37506.6 37631.0 37646.0 37739.0 2958.5 3073.3 3325.2 3643.4 3669.1 27742.6 27967.3 28231.6 30547.4 30820.2 2956.8 2966.9 2995.6 3023.4 3038.6 216414.0 217827.0 218709.0 218766.0 219662.0 52744.7 53896.7 57097.0 57634.0 58778.1 57488.4 57597.4 57908.0 57989.0 58060.0 14633.0 14651.0 14706.0 14817.0 14867.4 10621.9 10636.6 10661.1 10681.9 10691.0 19548.9 20050.4 20089.8 20108.7 20218.2 7806.0 8090.2 8099.7 8101.8 8181.2 826.6 906.4 1046.2 1068.0 1075.2 26359.5 26424.6 26635.5 26717.7 26808.7 923.4 939.2 974.2 985.8 1088.5 13839.0 13893.9 14053.4 14174.1 14194.6 254543.0 261028.0 261871.0 262510.0 263078.0 46654.5 47470.8 47658.3 47701.0 47701.3 1199.6 1200.1 1200.7 1204.7 1354.3 25323.4 25403.2 25779.0 25829.7 26018.7 40710.8 40736.4 40989.4 41052.0 41287.4 242814.0 246083.0 246255.0 246829.0 246830.0 29637.0 43590.8 44305.1 44748.0 44971.3 39657.0 40084.0 46283.8 47180.8 47381.0 33553.3 33633.3 34231.7 34416.8 34791.0 33600.2 33647.0 33913.7 34134.7 34215.5 33613.8 33947.7 33947.8 34197.5 34283.7 28979.3 30656.8 31117.4 31246.2 31405.4 23989.8 24046.3 24100.8 24132.2 24199.0 22:55:14 INFO - 2015-12-11 22:55:14,547 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,547 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25670.25 Median:2275.19 stddev:75889.96 (3335.5%) stddev-sans-first:76078.99 22:55:14 INFO - 2015-12-11 22:55:14,548 DEBUG : BROWSER_OUTPUT: Values: 329.8 332.2 333.1 333.1 336.2 14582.0 15085.0 15344.4 16215.8 16786.9 14392.9 14651.5 15456.7 15465.9 15534.4 4529.7 4752.8 4754.6 4759.4 4760.3 4730.7 4755.8 4756.4 4758.6 4760.8 3498.1 3607.8 4687.3 4715.5 5275.9 5330.2 5390.7 5392.8 5396.3 5409.3 5014.7 5116.9 5122.3 5206.6 5217.1 12193.1 12246.1 13944.8 19062.3 19198.4 1809.4 1870.8 1893.3 1901.4 1941.0 8468.1 8910.7 10508.7 12704.4 13004.5 1762.8 1779.9 1794.7 1812.9 1821.3 53336.0 56366.6 56897.0 57174.0 57651.7 9043.5 9048.3 9051.4 9113.8 9132.5 10884.3 10911.1 10933.3 11011.2 11017.4 6980.5 7042.5 7078.5 7157.8 7161.4 7088.4 7116.7 7130.9 7132.3 7152.4 3683.3 3781.1 4162.7 4243.4 4258.9 1584.3 1595.2 1596.5 1617.3 1650.7 383.9 387.7 833.0 922.9 939.9 9700.1 10163.1 15293.6 15976.6 15995.9 883.8 887.5 917.1 926.8 974.9 8801.7 8888.0 9116.0 9382.0 9595.1 450095.0 451644.0 469158.0 472781.0 474158.0 71474.6 74143.6 74868.0 75203.6 75500.6 1104.3 1111.3 1114.1 1115.4 1115.7 14536.3 14614.6 14759.8 14936.8 14973.9 33914.8 34024.1 34853.8 35243.0 35581.0 44861.1 45350.5 47724.0 47919.8 48571.0 8891.5 9057.5 9123.8 9129.6 9148.4 10676.3 12642.6 15889.9 15975.0 16071.1 12975.5 13544.3 13557.1 14150.4 14157.6 11347.3 12072.3 12577.1 12961.2 13213.8 13385.3 13461.3 13551.5 13738.2 14289.1 8554.3 8723.3 8803.9 8819.6 8858.8 9320.4 9452.5 12330.8 13083.2 13391.9 22:55:14 INFO - 2015-12-11 22:55:14,548 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,549 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4796.62 Median:5921.57 stddev:2470.60 (41.7%) stddev-sans-first:2464.35 22:55:14 INFO - 2015-12-11 22:55:14,549 DEBUG : BROWSER_OUTPUT: Values: 1400.6 1465.7 1578.9 1605.3 1711.6 5754.4 6041.4 6621.3 6946.3 6956.7 6592.1 6795.3 6862.5 6864.3 6871.1 2017.8 2045.0 2059.6 2061.8 2069.8 2081.4 2092.4 2106.3 2108.9 2133.1 2013.2 2041.9 2048.8 2049.2 2051.9 2035.7 2061.4 2064.0 2064.3 2065.0 2013.6 2033.2 2043.1 2055.4 2061.2 6836.9 6970.7 6971.9 6981.3 6985.2 4042.0 4112.9 4131.5 4137.2 4137.9 2660.1 2676.7 2688.8 2717.4 2740.7 864.6 865.8 873.6 873.7 900.3 8950.9 8974.3 9031.6 9063.1 9069.9 3686.5 3691.5 3767.6 3769.3 3782.3 7867.6 7880.3 7913.5 7921.7 7922.3 4068.3 4069.3 4071.4 4082.2 4090.1 3162.7 3249.7 3717.9 3746.1 3754.1 3385.3 3388.5 3402.9 3432.4 3439.8 1038.5 1043.4 1044.4 1050.9 1054.4 992.0 1017.7 1020.0 1020.0 1054.5 6495.4 6551.5 6562.7 6614.0 6617.5 416.8 417.4 418.4 423.2 424.5 5090.0 5127.5 5132.2 5133.4 5134.5 7823.3 8032.8 8048.5 8060.3 8169.3 7950.3 7969.6 7993.4 8006.2 8010.2 6518.0 6551.8 6582.5 6633.5 6687.3 6613.4 6663.4 6664.7 6674.7 6691.3 7369.6 7485.1 7542.7 7591.4 7663.1 7538.1 7629.2 7669.3 7688.1 7728.3 5393.5 5514.7 5887.2 6161.2 6238.3 6491.1 6491.5 6493.3 6496.4 6520.3 6000.0 6176.4 6207.1 6213.3 6290.7 6069.3 6141.6 6171.3 6230.8 6282.6 6127.6 6171.3 6179.5 6181.8 6181.9 5836.7 5846.1 5870.4 5878.0 5906.0 5846.2 5911.3 5920.6 5922.5 5928.9 22:55:14 INFO - 2015-12-11 22:55:14,549 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,549 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4894.29 Median:5595.60 stddev:1471.50 (26.3%) stddev-sans-first:1434.59 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: Values: 296.8 304.0 304.9 306.9 309.1 5550.3 5562.3 5714.1 5720.9 5723.0 5559.9 5564.9 5590.6 5600.6 5605.8 4166.3 4360.2 4364.5 4365.3 4369.9 4261.3 4261.7 4275.6 4307.1 4316.7 4237.1 4237.3 4239.4 4242.2 4253.6 4226.1 4242.5 4257.0 4260.4 4260.4 3689.1 3695.5 3700.0 3700.2 3701.2 5280.9 5285.8 5438.3 5450.2 5480.2 4898.5 4903.0 4907.7 4909.4 4913.9 5926.9 5936.6 5939.5 5952.0 5958.2 3938.7 4004.1 4015.2 4015.6 4032.3 6159.4 6250.6 6254.3 6260.2 6260.4 4145.6 4147.7 4151.1 4152.5 4156.6 4167.7 4202.1 4202.6 4215.1 4222.2 4711.3 4842.6 4863.1 4869.1 4880.5 5889.9 5897.0 5911.7 5918.6 5933.9 1483.4 1493.7 1493.9 1494.3 1494.8 976.0 979.3 988.7 996.6 999.3 5184.2 5185.5 5193.0 5204.5 5206.7 6126.2 6128.4 6128.5 6145.5 6164.5 5154.1 5170.5 5186.9 5198.0 5210.3 3221.4 3283.4 3337.9 3344.6 3348.7 5708.3 5742.2 5805.9 5837.2 5866.9 6396.7 6441.7 6442.6 6447.5 6448.3 5805.2 5848.4 5851.8 5859.4 5861.1 6157.2 6180.4 6220.6 6234.8 6241.7 5901.3 6063.1 6089.9 6090.1 6107.4 5778.6 5820.2 5827.4 5841.2 5847.7 4113.0 4156.8 4160.5 4169.2 4169.7 6016.5 6199.0 6201.0 6204.8 6220.9 5920.3 5937.3 5944.2 5947.9 5967.4 5936.4 5939.9 5949.7 5953.2 5957.2 5585.9 5752.9 5810.0 5811.5 5815.9 5965.3 6003.0 6013.1 6024.2 6026.4 5814.4 5848.4 5855.6 5860.1 5874.7 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12194.42 Median:22491.76 stddev:13881.49 (61.7%) stddev-sans-first:13893.34 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: Values: 645.4 680.3 721.1 782.6 788.5 11199.8 11548.6 11551.4 11562.7 11617.3 11644.1 11830.3 11834.6 11852.5 11856.8 618.0 623.6 780.8 805.3 815.0 790.6 804.5 805.7 806.7 807.1 841.8 843.8 844.3 844.3 844.5 828.2 831.3 832.8 834.3 844.9 626.5 626.6 631.7 634.0 637.4 11971.8 11979.0 11991.3 11991.4 12030.3 10607.3 10708.3 10740.8 10806.0 10862.9 8566.4 8890.1 8898.0 8938.6 9192.8 3235.5 3292.4 3314.3 3355.3 3381.8 39926.0 40013.4 40059.4 40140.6 40351.0 7651.4 7671.5 7851.8 7954.3 8061.2 15511.5 15573.8 15581.0 15644.8 15739.4 6041.2 6250.7 6299.0 6408.4 6417.3 3496.9 3593.4 3637.9 3645.7 3659.8 2638.1 2649.0 2665.0 2676.3 2677.8 450.0 452.3 458.3 468.6 469.6 429.4 539.8 556.6 563.5 610.0 7193.4 7457.0 7491.6 7744.5 7766.8 460.5 478.9 488.7 497.7 612.5 3646.2 3690.9 3734.8 4049.9 4064.9 49570.5 50425.2 50463.2 50469.5 50725.0 43767.6 44462.0 44533.6 44996.6 45143.8 41091.4 41275.6 41467.0 41596.4 41815.4 7733.5 8123.9 8218.3 8246.9 8348.1 31642.4 31864.5 31897.0 31907.7 32378.2 36980.5 37021.6 39351.6 40294.8 40579.2 9660.2 9722.3 10104.5 10304.0 10461.6 11087.4 11170.6 11513.7 11767.9 11856.5 10871.3 10950.0 11030.9 11079.4 11602.6 10672.1 10714.0 10879.2 11140.3 11171.7 9302.0 10477.0 10577.8 10579.6 10744.9 9039.2 9182.2 9201.7 9257.8 9383.1 8589.4 8762.0 8800.2 9000.4 9010.5 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:55:14 INFO - 2015-12-11 22:55:14,550 DEBUG : BROWSER_OUTPUT: 22:55:15 INFO - 2015-12-11 22:55:15,272 INFO : Browser exited with error code: 0 22:55:15 INFO - 2015-12-11 22:55:15,293 INFO : Completed test dromaeo_css (00:18:37) 22:55:15 INFO - 2015-12-11 22:55:15,293 INFO : Starting test kraken 22:55:15 INFO - 2015-12-11 22:55:15,293 DEBUG : operating with platform_type : linux_ 22:55:15 INFO - 2015-12-11 22:55:15,293 INFO : Initialising browser for kraken test... 22:55:15 INFO - 2015-12-11 22:55:15,299 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_Rl4h/profile http://localhost:33368/getInfo.html 22:55:20 INFO - 2015-12-11 22:55:20,000 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:55:20 INFO - 2015-12-11 22:55:20,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:55:20 INFO - 2015-12-11 22:55:20,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:55:20 INFO - 2015-12-11 22:55:20,000 DEBUG : BROWSER_OUTPUT: __metrics 22:55:20 INFO - 2015-12-11 22:55:20,137 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] 22:55:21 INFO - 2015-12-11 22:55:21,104 INFO : Browser initialized. 22:55:21 INFO - 2015-12-11 22:55:21,104 INFO : Running cycle 1/1 for kraken test... 22:55:21 INFO - 2015-12-11 22:55:21,105 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_Rl4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:55:33 INFO - 2015-12-11 22:55:33,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 143327232 22:55:33 INFO - 2015-12-11 22:55:33,102 DEBUG : BROWSER_OUTPUT: 22:55:35 INFO - 2015-12-11 22:55:35,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33368/tests/kraken/driver.html?testName=audio-beat-detection) 22:55:36 INFO - 2015-12-11 22:55:36,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 144797696 22:55:36 INFO - 2015-12-11 22:55:36,303 DEBUG : BROWSER_OUTPUT: 22:55:39 INFO - 2015-12-11 22:55:39,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33368/tests/kraken/driver.html?testName=audio-dft) 22:55:39 INFO - 2015-12-11 22:55:39,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 143876096 22:55:39 INFO - 2015-12-11 22:55:39,636 DEBUG : BROWSER_OUTPUT: 22:55:42 INFO - 2015-12-11 22:55:42,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33368/tests/kraken/driver.html?testName=audio-fft) 22:55:43 INFO - 2015-12-11 22:55:43,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 137789440 22:55:43 INFO - 2015-12-11 22:55:43,141 DEBUG : BROWSER_OUTPUT: 22:55:45 INFO - 2015-12-11 22:55:45,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33368/tests/kraken/driver.html?testName=audio-oscillator) 22:55:45 INFO - 2015-12-11 22:55:45,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 138522624 22:55:45 INFO - 2015-12-11 22:55:45,799 DEBUG : BROWSER_OUTPUT: 22:55:48 INFO - 2015-12-11 22:55:48,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:55:48 INFO - 2015-12-11 22:55:48,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 139374592 22:55:48 INFO - 2015-12-11 22:55:48,627 DEBUG : BROWSER_OUTPUT: 22:55:51 INFO - 2015-12-11 22:55:51,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33368/tests/kraken/driver.html?testName=imaging-darkroom) 22:55:52 INFO - 2015-12-11 22:55:52,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 140902400 22:55:52 INFO - 2015-12-11 22:55:52,256 DEBUG : BROWSER_OUTPUT: 22:55:55 INFO - 2015-12-11 22:55:55,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33368/tests/kraken/driver.html?testName=imaging-desaturate) 22:55:56 INFO - 2015-12-11 22:55:56,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 137191424 22:55:56 INFO - 2015-12-11 22:55:56,332 DEBUG : BROWSER_OUTPUT: 22:55:59 INFO - 2015-12-11 22:55:59,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33368/tests/kraken/driver.html?testName=json-parse-financial) 22:55:59 INFO - 2015-12-11 22:55:59,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 137523200 22:55:59 INFO - 2015-12-11 22:55:59,837 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-12-11 22:56:01,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:56:02 INFO - 2015-12-11 22:56:02,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 140099584 22:56:02 INFO - 2015-12-11 22:56:02,208 DEBUG : BROWSER_OUTPUT: 22:56:04 INFO - 2015-12-11 22:56:04,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:56:04 INFO - 2015-12-11 22:56:04,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 22:56:04 INFO - 2015-12-11 22:56:04,728 DEBUG : BROWSER_OUTPUT: 22:56:06 INFO - 2015-12-11 22:56:06,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:56:07 INFO - 2015-12-11 22:56:07,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 140099584 22:56:07 INFO - 2015-12-11 22:56:07,475 DEBUG : BROWSER_OUTPUT: 22:56:10 INFO - 2015-12-11 22:56:10,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:56:10 INFO - 2015-12-11 22:56:10,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 139829248 22:56:10 INFO - 2015-12-11 22:56:10,640 DEBUG : BROWSER_OUTPUT: 22:56:13 INFO - 2015-12-11 22:56:13,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:56:13 INFO - 2015-12-11 22:56:13,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 139788288 22:56:13 INFO - 2015-12-11 22:56:13,911 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33368/tests/kraken/driver.html?testName=ai-astar) 22:56:15 INFO - 2015-12-11 22:56:15,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 140750848 22:56:15 INFO - 2015-12-11 22:56:15,951 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,952 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:15 INFO - 2015-12-11 22:56:15,952 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:15 INFO - 2015-12-11 22:56:15,952 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:15 INFO - 2015-12-11 22:56:15,953 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:15 INFO - 2015-12-11 22:56:15,953 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;114;114;115;117;123;113;113;112;113 22:56:15 INFO - 2015-12-11 22:56:15,953 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;161;183;130;155;156;134;172;131 22:56:15 INFO - 2015-12-11 22:56:15,953 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;164;162;164;174;165;166;162 22:56:15 INFO - 2015-12-11 22:56:15,953 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;73;73;73;122;72;79;72;72 22:56:15 INFO - 2015-12-11 22:56:15,954 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;141;94;95;94;135;95;96;129 22:56:15 INFO - 2015-12-11 22:56:15,954 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;111;109;111;111;109 22:56:15 INFO - 2015-12-11 22:56:15,954 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;149;148;148;147;149;148;147 22:56:15 INFO - 2015-12-11 22:56:15,955 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;96;96;96;96;96;96 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;75;74;77;76;76;76;75;75 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;68;70;68;69;68;68;68 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;89;87;87;88;88;95;89;87 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;118;124;126;121;121;140;122;125;128 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;153;159;155;143;158;153;151;147 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;71;70;72;74;71;73;69;74 22:56:15 INFO - 2015-12-11 22:56:15,956 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:15 INFO - 2015-12-11 22:56:15,957 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:56:15 INFO - 2015-12-11 22:56:15,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 22:56:15 INFO - 2015-12-11 22:56:15,957 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:56:15 INFO - 2015-12-11 22:56:15,957 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903375952__endTimestamp 22:56:15 INFO - 2015-12-11 22:56:15,957 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,960 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:3.20 (2.8%) stddev-sans-first:3.37 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: Values: 116.0 114.0 114.0 115.0 117.0 123.0 113.0 113.0 112.0 113.0 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.50 stddev:18.60 (12.0%) stddev-sans-first:19.67 22:56:15 INFO - 2015-12-11 22:56:15,961 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 161.0 183.0 130.0 155.0 156.0 134.0 172.0 131.0 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.79 (2.3%) stddev-sans-first:3.84 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 164.0 162.0 164.0 174.0 165.0 166.0 162.0 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.40 Median:73.00 stddev:15.46 (21.2%) stddev-sans-first:16.31 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 73.0 73.0 73.0 122.0 72.0 79.0 72.0 72.0 22:56:15 INFO - 2015-12-11 22:56:15,962 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.50 stddev:19.67 (20.8%) stddev-sans-first:20.40 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 141.0 94.0 95.0 94.0 135.0 95.0 96.0 129.0 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 111.0 109.0 111.0 111.0 109.0 22:56:15 INFO - 2015-12-11 22:56:15,963 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 149.0 148.0 148.0 147.0 149.0 148.0 147.0 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,964 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:75.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 22:56:15 INFO - 2015-12-11 22:56:15,965 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 75.0 74.0 77.0 76.0 76.0 76.0 75.0 75.0 22:56:15 INFO - 2015-12-11 22:56:15,965 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,965 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 22:56:15 INFO - 2015-12-11 22:56:15,965 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 70.0 68.0 69.0 68.0 68.0 68.0 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.00 stddev:2.54 (2.9%) stddev-sans-first:2.55 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 89.0 87.0 87.0 88.0 88.0 95.0 89.0 87.0 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.50 stddev:6.09 (4.9%) stddev-sans-first:6.38 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 124.0 126.0 121.0 121.0 140.0 122.0 125.0 128.0 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,966 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:153.50 stddev:6.00 (3.9%) stddev-sans-first:5.05 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 153.0 159.0 155.0 143.0 158.0 153.0 151.0 147.0 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.62 (2.2%) stddev-sans-first:1.72 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 70.0 72.0 74.0 71.0 73.0 69.0 74.0 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:15 INFO - 2015-12-11 22:56:15,967 DEBUG : BROWSER_OUTPUT: 22:56:16 INFO - 2015-12-11 22:56:16,904 INFO : Browser exited with error code: 0 22:56:16 INFO - 2015-12-11 22:56:16,955 INFO : Completed test kraken (00:01:01) 22:56:16 INFO - 2015-12-11 22:56:16,955 INFO : Starting test v8_7 22:56:16 INFO - 2015-12-11 22:56:16,955 DEBUG : operating with platform_type : linux_ 22:56:16 INFO - 2015-12-11 22:56:16,955 INFO : Initialising browser for v8_7 test... 22:56:16 INFO - 2015-12-11 22:56:16,961 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdYOil/profile http://localhost:33368/getInfo.html 22:56:21 INFO - 2015-12-11 22:56:21,722 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:56:21 INFO - 2015-12-11 22:56:21,722 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:56:21 INFO - 2015-12-11 22:56:21,722 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:56:21 INFO - 2015-12-11 22:56:21,722 DEBUG : BROWSER_OUTPUT: __metrics 22:56:21 INFO - 2015-12-11 22:56:21,839 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] 22:56:22 INFO - 2015-12-11 22:56:22,768 INFO : Browser initialized. 22:56:22 INFO - 2015-12-11 22:56:22,768 INFO : Running cycle 1/1 for v8_7 test... 22:56:22 INFO - 2015-12-11 22:56:22,768 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdYOil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:56:34 INFO - 2015-12-11 22:56:34,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 143491072 22:56:34 INFO - 2015-12-11 22:56:34,827 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33368/tests/v8_7/run.html (next: http://localhost:33368/tests/v8_7/run.html) 22:56:56 INFO - 2015-12-11 22:56:56,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 138289152 22:56:56 INFO - 2015-12-11 22:56:56,495 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,495 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:56 INFO - 2015-12-11 22:56:56,495 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |0;Richards;164.09583196586806 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.59762435040832 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 22:56:56 INFO - 2015-12-11 22:56:56,496 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: |5;Earley;700.2801120448179 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: |8;Splay;647.2491909385113 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 22:56:56 INFO - 2015-12-11 22:56:56,497 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:56 INFO - 2015-12-11 22:56:56,498 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903416494__endTimestamp 22:56:56 INFO - 2015-12-11 22:56:56,498 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,498 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:56 INFO - 2015-12-11 22:56:56,498 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:56:56 INFO - 2015-12-11 22:56:56,498 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.10 Median:164.10 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: Values: 164.1 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.60 Median:185.60 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: Values: 185.6 22:56:56 INFO - 2015-12-11 22:56:56,499 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,500 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,500 DEBUG : BROWSER_OUTPUT: Values: 278.7 22:56:56 INFO - 2015-12-11 22:56:56,500 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,501 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,501 DEBUG : BROWSER_OUTPUT: Values: 5143.6 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: Values: 1071.8 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: Values: 700.3 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,502 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: Values: 12256.1 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: Values: 26394.7 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:647.25 Median:647.25 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,503 DEBUG : BROWSER_OUTPUT: Values: 647.2 22:56:56 INFO - 2015-12-11 22:56:56,504 DEBUG : BROWSER_OUTPUT: 22:56:56 INFO - 2015-12-11 22:56:56,504 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 22:56:56 INFO - 2015-12-11 22:56:56,504 DEBUG : BROWSER_OUTPUT: Values: 4826.9 22:56:56 INFO - 2015-12-11 22:56:56,504 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:56 INFO - 2015-12-11 22:56:56,504 DEBUG : BROWSER_OUTPUT: 22:56:57 INFO - 2015-12-11 22:56:57,424 INFO : Browser exited with error code: 0 22:56:57 INFO - 2015-12-11 22:56:57,438 INFO : Completed test v8_7 (00:00:40) 22:56:57 INFO - 2015-12-11 22:56:57,522 INFO : Completed test suite (00:20:19) 22:56:57 INFO - 2015-12-11 22:56:57,522 DEBUG : Working with test: dromaeo_css 22:56:57 INFO - 2015-12-11 22:56:57,523 DEBUG : Generating results file: dromaeo_css 22:56:57 INFO - 2015-12-11 22:56:57,524 DEBUG : Working with test: kraken 22:56:57 INFO - 2015-12-11 22:56:57,524 DEBUG : Generating results file: kraken 22:56:57 INFO - 2015-12-11 22:56:57,524 INFO : javascript benchmark 22:56:57 INFO - 2015-12-11 22:56:57,524 DEBUG : Working with test: v8_7 22:56:57 INFO - 2015-12-11 22:56:57,524 DEBUG : Generating results file: v8_7 22:56:57 INFO - 2015-12-11 22:56:57,525 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:57 INFO - 2015-12-11 22:56:57,581 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:56:57 INFO - 2015-12-11 22:56:57,581 DEBUG : process_Request line: dromaeo_css 6329.80 graph.html#tests=[[72,132,43]] 22:56:57 INFO - 2015-12-11 22:56:57,581 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:57 INFO - 2015-12-11 22:56:57,619 DEBUG : process_Request line: kraken 1549.10 graph.html#tests=[[232,132,43]] 22:56:57 INFO - 2015-12-11 22:56:57,619 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:57 INFO - 2015-12-11 22:56:57,649 DEBUG : process_Request line: v8_7 21257.32 graph.html#tests=[[230,132,43]] 22:56:57 INFO - 2015-12-11 22:56:57,651 INFO : javascript benchmark 22:56:57 INFO - 2015-12-11 22:56:57,654 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2678.611601317809, 2719.2250208690525, 2740.7259274072594, 2754.4904192724334, 2768.0173538393874, 4596.770161491929, 4760.071786001727, 4808.735519546423, 4824.831130910419, 4826.734529600875, 4707.4351077870615, 4724.291356296557, 4749.0264495778365, 4755.667103302771, 4758.928616070762, 4353.477582690066, 4371.169477799216, 4419.9337009944875, 4499.212637788391, 4528.411306530146, 4497.280435130379, 4503.964088259702, 4549.226631472641, 4552.544745525437, 4597.126545956275, 4234.237837189305, 4497.033137875373, 4541.795619197128, 4560.612347950411, 4578.130155270488, 4281.250781113293, 4349.913001739979, 4393.51671316155, 4427.22523558376, 4471.038726673748, 4387.670924680661, 4414.80133393998, 4435.3125265583885, 4437.134758722018, 4469.463664360265, 4539.954600454019, 4644.814207431698, 4669.789859456333, 4681.578657920803, 4690.742009189493, 5070.138076527, 5182.663126896778, 5183.0670479314085, 5185.040767457995, 5229.398619158769, 5162.457941916082, 5210.088234558937, 5223.347081614798, 5243.239730239094, 5254.92117618236, 4634.791434385461, 4745.83389581363, 4784.0, 4814.1334559779225, 4840.806367745321, 5332.413434522199, 5339.41266460689, 5354.357477102694, 5378.381486129067, 5381.78472861089, 5115.820946266863, 5116.976604679079, 5122.334096567497, 5125.9743701282005, 5159.871003224875, 4892.241702536113, 4965.553100220997, 4988.55103040728, 4992.475790041994, 5237.450067742909, 5012.348394708664, 5052.191649336089, 5076.0863044652315, 5092.083424983539, 5124.692518448905, 5087.694738315713, 5094.898102037939, 5111.974440127776, 5116.641835071509, 5150.459201783834, 4116.300228961084, 4157.064660451374, 4283.87148385549, 4292.720973136736, 4321.438213032286, 3665.248624032067, 3724.795136267477, 3741.56971948224, 3761.1349389640536, 3763.284975854579, 4509.391232183613, 4512.165249428866, 4543.023250001265, 4552.567506086983, 4568.040711450566, 4929.088118698052, 5045.5459008689395, 5074.771635276422, 5239.083160446907, 5278.261043453843, 4531.68278220528, 4539.682222244477, 4553.385292985405, 4560.293154561048, 4607.7004994675235, 4592.931106033412, 4608.0, 4611.239145541015, 4611.2852507861335, 4658.976705116453, 4668.1363947669115, 4785.665003449864, 4787.952120478751, 4888.682235654671, 4938.259261110862, 5207.3230480037355, 5218.165093585008, 5226.11156103471, 5228.738563071755, 5234.528892399702, 4939.061578300111, 4945.925811112908, 4950.108980383421, 4951.702897826142, 4967.776450059684, 4864.756762161807, 4957.950420495749, 5021.196608542616, 5028.497150284942, 5108.872278192926, 5196.662216956037, 5213.244079608511, 5242.5281724644965, 5246.790128394821, 5255.763490642854, 5076.82231121909, 5077.695338279715, 5080.288759573588, 5089.491050895029, 5109.489051094861, 4793.664443488922, 4897.8285759998225, 4910.950890491193, 4953.133201689762, 5064.215046667772, 4905.754712264444, 4946.282788995647, 4947.703137811743, 4965.553100220997, 4994.950050499594, 5035.672681275705, 5076.695398276115, 5087.694738315713, 5099.847004589868, 5132.178851383761, 4743.952560474351, 4851.199552073868, 4876.634252431011, 4980.576650984707, 5014.323066385991], "unit": "ms", "name": "dojo.html", "value": 4723.8938250049705}, {"lowerIsBetter": false, "replicates": [545.9817440473518, 564.5201578658139, 567.1153001317945, 574.6724367110747, 577.1573502686078, 35855.46216806747, 36705.99999999996, 36809.07977300569, 36891.44662830056, 36966.0, 41282.0, 41927.0, 41959.370609440884, 41977.37033944493, 41988.79005604975, 7950.483218590787, 8177.79555511114, 8183.345332373426, 8190.959045204795, 8193.057798353206, 7910.169432209622, 7962.800929976739, 8027.919720802775, 8033.879491807627, 8035.879461808077, 7984.760457186294, 8044.959775201116, 8060.596970151469, 8091.676332946675, 8102.270795628392, 7980.481268717544, 8065.39509536787, 8069.031716194036, 8085.757427277133, 8106.432549721522, 7948.364130869574, 8057.6374063167295, 8074.555899425529, 8093.757187284391, 8123.0, 37269.0, 37506.62493375059, 37631.0, 37646.0, 37739.0, 2958.482265603532, 3073.2931425771976, 3325.218573635194, 3643.362411577963, 3669.1194113412857, 27742.583861242096, 27967.300817479725, 28231.57652635212, 30547.38905221883, 30820.2294942626, 2956.8373739444323, 2966.8961586344376, 2995.5806187133817, 3023.4104349651825, 3038.60498135241, 216414.0, 217827.0, 218709.0, 218766.0, 219662.0, 52744.73627631837, 53896.73051634717, 57097.0, 57634.0, 58778.11832822426, 57488.425115749145, 57597.42402576005, 57908.0, 57989.0, 58060.0, 14632.975691701478, 14651.0, 14706.0, 14817.0, 14867.405303787944, 10621.893781062245, 10636.574537018432, 10661.147108231324, 10681.893181068246, 10691.0, 19548.902255488916, 20050.398488045383, 20089.799102008794, 20108.698369524467, 20218.19127234894, 7805.960970195113, 8090.150534193943, 8099.716509922125, 8101.797455063671, 8181.181881811771, 826.5908375354238, 906.392716879679, 1046.2414749306845, 1067.9839802402971, 1075.2097208551709, 26359.47281054368, 26424.603630945552, 26635.46729065408, 26717.732822671915, 26808.731912681014, 923.4274749655123, 939.2157548446986, 974.2254907348674, 985.7732721474101, 1088.4666513408372, 13839.0, 13893.930530347283, 14053.367598458093, 14174.14955102697, 14194.645133871529, 254543.0, 261028.0, 261871.0, 262510.0, 263078.0, 46654.53345466502, 47470.76264618655, 47658.285125723145, 47701.0, 47701.284480732815, 1199.5921386728555, 1200.0759415250209, 1200.6698158006443, 1204.7108693913397, 1354.3431435753848, 25323.366915826515, 25403.237902862944, 25779.0, 25829.741702582734, 26018.73981260163, 40710.79644601758, 40736.3889541663, 40989.38515922204, 41052.0, 41287.380689289086, 242814.0, 246083.0, 246255.0, 246829.0, 246830.0, 29637.0, 43590.78204608957, 44305.11389772122, 44748.0, 44971.32543011923, 39657.0, 40084.0, 46283.76858115688, 47180.7640961793, 47381.0, 33553.32893342168, 33633.327333452704, 34231.65768342285, 34416.827915861264, 34791.0, 33600.15999600029, 33647.0, 33913.66086339105, 34134.65865341414, 34215.486767699, 33613.83193084019, 33947.66052339445, 33947.83026084854, 34197.48703769396, 34283.657163429045, 28979.275518112216, 30656.846715766278, 31117.377652447278, 31246.21884452907, 31405.371892562478, 23989.76010239875, 24046.27861164168, 24100.75899240985, 24132.155374561808, 24199.0], "unit": "ms", "name": "ext.html", "value": 17378.58832305177}, {"lowerIsBetter": false, "replicates": [329.80211872876265, 332.220941891265, 333.07239338442434, 333.107272509674, 336.1746911332676, 14582.0, 15085.0, 15344.386224551019, 16215.83784162158, 16786.916065419657, 14392.928035359835, 14651.487197948074, 15456.69086618267, 15465.92267038666, 15534.378624854991, 4529.728216307016, 4752.7861246244, 4754.572088512034, 4759.428868535781, 4760.33355330254, 4730.668853180278, 4755.785989630458, 4756.3816703828625, 4758.571728544431, 4760.809567617292, 3498.142954976022, 3607.801570913599, 4687.343771871923, 4715.528447155274, 5275.868103297429, 5330.200469929503, 5390.676559406448, 5392.838214853561, 5396.298481197419, 5409.323834520685, 5014.674046187022, 5116.923246151274, 5122.33409656746, 5206.609504287194, 5217.113090774577, 12193.085518586142, 12246.142770006103, 13944.790828137586, 19062.33281835129, 19198.424047278604, 1809.4390738870993, 1870.8035656256034, 1893.280553389717, 1901.4105627255456, 1940.9708854367195, 8468.110848360957, 8910.732678019669, 10508.684739457753, 12704.364781760967, 13004.479820807157, 1762.8237176282398, 1779.9377021804175, 1794.6949018666858, 1812.9274829006824, 1821.298799962011, 53336.0, 56366.590835229035, 56897.0, 57174.0, 57651.711741441446, 9043.502607356659, 9048.321375896834, 9051.411658242194, 9113.772155696028, 9132.452052876848, 10884.346939183675, 10911.072558832588, 10933.28933619328, 11011.229213955106, 11017.394043327695, 6980.511364204558, 7042.507024508338, 7078.504504684623, 7157.785266442015, 7161.427085833121, 7088.432925365958, 7116.715331386687, 7130.894711319754, 7132.286771322826, 7152.392046675986, 3683.318586061587, 3781.0736369589627, 4162.708610397303, 4243.448351714257, 4258.914821703549, 1584.294988730004, 1595.2183430119157, 1596.5290239379178, 1617.3045590396243, 1650.7358822588328, 383.8925100971732, 387.6666067182221, 832.9875051874227, 922.8707980882682, 939.9295052871062, 9700.116604710038, 10163.136133428594, 15293.617659558378, 15976.600584985468, 15995.920020399824, 883.8409086364387, 887.5429153985702, 917.0508523677961, 926.8285367207088, 974.907383798538, 8801.735947921572, 8887.955560222157, 9116.028951428436, 9381.953090234505, 9595.13643772064, 450095.0, 451644.0, 469158.0, 472781.0, 474158.0, 71474.64262678758, 74143.62928185324, 74868.0, 75203.62398188084, 75500.62249688717, 1104.2987702808775, 1111.2943281016612, 1114.0808832712883, 1115.3865374044406, 1115.65414721435, 14536.345864436338, 14614.634634134232, 14759.778603320745, 14936.775948361, 14973.925130374279, 33914.830425847715, 34024.14939626529, 34853.82573087118, 35243.0, 35581.0, 44861.102777943604, 45350.54649453595, 47724.0, 47919.76040119777, 48571.028579427504, 8891.4665120093, 9057.501837399006, 9123.817523649357, 9129.634814607341, 9148.359614826899, 10676.252662313564, 12642.55751048709, 15889.920550397173, 15975.0, 16071.11608861524, 12975.480980760663, 13544.255065971467, 13557.118787278796, 14150.363233654716, 14157.575272741835, 11347.262427942158, 12072.33602151855, 12577.119601627799, 12961.15752476086, 13213.801792973305, 13385.263810490516, 13461.326933653474, 13551.457941682616, 13738.175709457464, 14289.142651440947, 8554.31565474773, 8723.302135828992, 8803.899512560929, 8819.559022048743, 8858.778530536789, 9320.440773553337, 9452.480113593818, 12330.81503777426, 13083.215007099605, 13391.86608133945], "unit": "ms", "name": "jquery.html", "value": 8083.747793792606}, {"lowerIsBetter": false, "replicates": [1400.6428360768007, 1465.699531596023, 1578.928948197331, 1605.2856478866909, 1711.5806627376287, 5754.424557544244, 6041.365656606048, 6621.304762999882, 6946.305369463057, 6956.6521673916295, 6592.143021407211, 6795.286494918037, 6862.451003919687, 6864.279250678669, 6871.072405225293, 2017.798220177985, 2045.0388317490756, 2059.639563076463, 2061.7525896892394, 2069.772325044244, 2081.375587323804, 2092.3618296419586, 2106.3154474795674, 2108.9367318980453, 2133.1467413034834, 2013.2249084102652, 2041.8979051047463, 2048.754149502062, 2049.241780541202, 2051.897405129745, 2035.6641154209537, 2061.3506745375234, 2063.9896800515903, 2064.349729835097, 2064.9690254646193, 2013.6476116679523, 2033.2070492507933, 2043.1112466077304, 2055.4450298419342, 2061.2167376396874, 6836.897446538306, 6970.651467426608, 6971.930280697179, 6981.3367730065565, 6985.19670237924, 4042.0, 4112.856050038265, 4131.5248746394245, 4137.213929353413, 4137.903455584273, 2660.1088635307196, 2676.6921803992595, 2688.75801177893, 2717.429339838636, 2740.7122252163435, 864.5633954852759, 865.7705707987388, 873.5763154869883, 873.6592728835759, 900.3337530227584, 8950.910490895138, 8974.326925480615, 9031.593578288992, 9063.13900179482, 9069.863952040725, 3686.4838922550866, 3691.483192353073, 3767.56672982605, 3769.2838360711376, 3782.319182547168, 7867.6459559319965, 7880.330171935335, 7913.485623434458, 7921.732522796325, 7922.326602238874, 4068.2880495913096, 4069.348904175318, 4071.3892916062237, 4082.2243773682903, 4090.1206240658403, 3162.7469802415753, 3249.7237734792334, 3717.888463346104, 3746.0822098586023, 3754.08025033863, 3385.25524384635, 3388.508666243381, 3402.897913062612, 3432.3650124727005, 3439.8280085995602, 1038.5326603028668, 1043.4209013997154, 1044.3733759744246, 1050.9421981791074, 1054.3621109228807, 991.9752006199902, 1017.7353887989028, 1019.9643012494527, 1019.9847002294972, 1054.5465449856636, 6495.447886929569, 6551.508636852255, 6562.67186640666, 6613.966930165318, 6617.4706023518, 416.82493352791903, 417.36560428149045, 418.35155508960986, 423.1632441197085, 424.45245633132913, 5090.0, 5127.4872512748425, 5132.153194722829, 5133.383993920679, 5134.512221338967, 7823.2567906048835, 8032.839343213103, 8048.5170889746805, 8060.274575288252, 8169.2647661710735, 7950.284474397332, 7969.561674107979, 7993.400494962901, 8006.199380062064, 8010.19898010206, 6518.0, 6551.836204094936, 6582.473402127914, 6633.4693224541925, 6687.264400915896, 6613.371729685672, 6663.36698013688, 6664.700088496126, 6674.699638516181, 6691.330866913269, 7369.557826530211, 7485.1017877855, 7542.698292068256, 7591.430642701709, 7663.118741344817, 7538.09542854861, 7629.198934112061, 7669.309762121213, 7688.077430708351, 7728.26581474759, 5393.541548968382, 5514.669119852661, 5887.234659494238, 6161.199044124235, 6238.251409830849, 6491.058796474579, 6491.545591808717, 6493.318201588765, 6496.350364963466, 6520.347965203631, 6000.0, 6176.413240742122, 6207.099970504342, 6213.347598502273, 6290.748370065146, 6069.332373439007, 6141.631502109888, 6171.290301615371, 6230.7507699693315, 6282.623042617458, 6127.632342059491, 6171.290301615371, 6179.5056395489155, 6181.752729890754, 6181.938180618136, 5836.678982655825, 5846.123081537803, 5870.442307980735, 5877.970610146922, 5906.025505791668, 5846.1815345852465, 5911.290645122441, 5920.644761314335, 5922.496587789914, 5928.8814223716145], "unit": "ms", "name": "mootools.html", "value": 3887.649337637653}, {"lowerIsBetter": false, "replicates": [296.84267338310696, 303.99544006839886, 304.8536702382855, 306.87418158555, 309.14829644329876, 5550.2507161533185, 5562.3047119110115, 5714.114312281593, 5720.914186287198, 5722.971385143073, 5559.8888022239535, 5564.916526252109, 5590.6239848064615, 5600.5799565032685, 5605.775768969246, 4166.291730405823, 4360.23695853226, 4364.454443194601, 4365.323374876899, 4369.868903932879, 4261.254280500915, 4261.659067274626, 4275.615194632483, 4307.1170410066015, 4316.654667626598, 4237.110206856564, 4237.258479766044, 4239.3852891330735, 4242.172776308621, 4253.638440732541, 4226.091390351058, 4242.469691288589, 4257.020885196423, 4260.360945858146, 4260.4248426462655, 3689.1330537323706, 3695.4826324314618, 3700.0379901225606, 3700.204456041937, 3701.1857391373856, 5280.9471905281225, 5285.762140703678, 5438.320209973754, 5450.182472629098, 5480.205370221335, 4898.461169271377, 4902.975485122587, 4907.705537667715, 4909.386326709161, 4913.8771530711665, 5926.940730592682, 5936.643801371888, 5939.465448109648, 5952.0476723724, 5958.165856780054, 3938.72428929975, 4004.0990777074926, 4015.1768887378016, 4015.6185162409815, 4032.2741906457118, 6159.38406159385, 6250.624962502265, 6254.312025677172, 6260.248770147611, 6260.373962603749, 4145.606167414091, 4147.688923330702, 4151.14901445203, 4152.501699795984, 4156.649089046072, 4167.708260421741, 4202.138561594866, 4202.579742025834, 4215.072684009513, 4222.218889505451, 4711.340412342275, 4842.564169224786, 4863.148948933923, 4869.123557759637, 4880.536349046835, 5889.911651325234, 5896.997510423153, 5911.733971971272, 5918.585699001114, 5933.881322373529, 1483.391809358158, 1493.6788590453104, 1493.8954273200989, 1494.2827442827504, 1494.7757836324638, 975.9560819763128, 979.3487330924997, 988.6737376665683, 996.6312464388222, 999.2705325112563, 5184.222366644958, 5185.507376799198, 5193.039287731782, 5204.505571970657, 5206.687598744087, 6126.203593532901, 6128.387161283925, 6128.540359473057, 6145.508359331243, 6164.4760195383, 5154.098032844237, 5170.508801663836, 5186.870328241749, 5197.974010129925, 5210.348706411699, 3221.4362486564755, 3283.4254005548933, 3337.916552086217, 3344.6320904700465, 3348.7321014318795, 5708.343540492813, 5742.16738572913, 5805.854853628609, 5837.211976383219, 5866.882662346729, 6396.712147953353, 6441.710123044474, 6442.5812322199845, 6447.516436267299, 6448.258450278278, 5805.187273781674, 5848.444397782204, 5851.824445266649, 5859.414058594107, 5861.062230043172, 6157.168782214344, 6180.443760061616, 6220.626762394271, 6234.786650739104, 6241.690574487287, 5901.262342207224, 6063.060225665029, 6089.939100608937, 6090.086487026982, 6107.358727333566, 5778.595498315078, 5820.156077368673, 5827.358990511125, 5841.211436456024, 5847.7368518417625, 4113.0, 4156.8129434174925, 4160.479940007499, 4169.207850508394, 4169.728967617095, 6016.458518733335, 6199.0, 6200.968995154995, 6204.844878878064, 6220.875582488416, 5920.319163296103, 5937.2578427696535, 5944.1975333331175, 5947.91078133837, 5967.37342579023, 5936.406359364029, 5939.940600594112, 5949.702514874326, 5953.226080609493, 5957.225560677258, 5585.916211256753, 5752.9137062943255, 5810.041343178328, 5811.506021988178, 5815.912761308499, 5965.254343207099, 6003.039513677791, 6013.067974463965, 6024.216851809412, 6026.427489388501, 5814.447627475383, 5848.444397782204, 5855.560832937632, 5860.062390017577, 5874.676892770939], "unit": "ms", "name": "prototype.html", "value": 4413.906893201416}, {"lowerIsBetter": false, "replicates": [645.4126744662358, 680.2992917295188, 721.1310371002942, 782.6047845837853, 788.5150632361098, 11199.83200251996, 11548.595799147031, 11551.364674942875, 11562.710932226699, 11617.302961822297, 11644.068474522039, 11830.290182589051, 11834.644960651194, 11852.466639001244, 11856.822147667792, 617.9752809887599, 623.6227082615021, 780.8204113053987, 805.3275514945028, 814.9755507334789, 790.5770412829138, 804.4690504267155, 805.7018903005896, 806.7136166660839, 807.0517142357736, 841.8105926166594, 843.7932706486889, 844.2950136635916, 844.3034496540379, 844.4933040175907, 828.1801016993134, 831.2850948184556, 832.8292699996487, 834.3241974001048, 844.8817165596821, 626.495670984857, 626.5864529410612, 631.6999425273004, 634.0046127579702, 637.37537213531, 11971.820422693667, 11979.0, 11991.28052316855, 11991.400429978466, 12030.27818330903, 10607.310524815863, 10708.25042247043, 10740.838887416696, 10806.0, 10862.891371086345, 8566.443181193203, 8890.06654301302, 8898.0, 8938.597763100675, 9192.770180745469, 3235.5308480270464, 3292.423825830494, 3314.2708604107056, 3355.312161006988, 3381.8140002299865, 39926.0018499537, 40013.39979900304, 40059.39910901368, 40140.59859401398, 40351.0, 7651.4261430391825, 7671.501352412187, 7851.803704907309, 7954.284114429729, 8061.1938806118915, 15511.5346539604, 15573.766393504107, 15580.987235829862, 15644.765328520081, 15739.44911928077, 6041.24484439445, 6250.656213908279, 6299.023651334051, 6408.391202835724, 6417.26201486835, 3496.947545786815, 3593.4250519916686, 3637.8726744563814, 3645.671889529955, 3659.835307411173, 2638.129417292327, 2648.9867550662507, 2665.0, 2676.2907829425217, 2677.812553121302, 449.97300161990387, 452.3079688077247, 458.30795498797056, 468.6227586792597, 469.58207195595946, 429.4138500946186, 539.8204575052941, 556.5547561950505, 563.4872266237704, 609.9969500152471, 7193.424526037905, 7456.96271518639, 7491.550506969599, 7744.49660772048, 7766.844663106706, 460.4543615815203, 478.85873667268237, 488.68479830509835, 497.6566169343142, 612.5008118383503, 3646.161382881952, 3690.8892733218045, 3734.7572407793405, 4049.919001619951, 4064.898377540585, 49570.50429495731, 50425.24362134571, 50463.24305135426, 50469.49530504721, 50725.0, 43767.56232437635, 44462.0, 44533.55466445294, 44996.55003449989, 45143.77428112838, 41091.38362924558, 41275.587244127775, 41467.0, 41596.37605435981, 41815.37276940788, 7733.458657893893, 8123.878141827996, 8218.260356567938, 8246.876296855671, 8348.123447038217, 31642.36715265728, 31864.522032169072, 31897.0, 31907.68092319047, 32378.190545236557, 36980.52077916853, 37021.62978370182, 39351.6064839348, 40294.79852600718, 40579.18841623092, 9660.227181825578, 9722.27082968766, 10104.494775261355, 10304.0, 10461.633842815465, 11087.41369732543, 11170.609028683957, 11513.712157196138, 11767.937314908944, 11856.466459009192, 10871.29336593119, 10950.0, 11030.889691103308, 11079.390633515233, 11602.593909213138, 10672.092872105957, 10714.0, 10879.23845330851, 11140.33158010522, 11171.664850054187, 9301.953490232505, 10477.0, 10577.841332379867, 10579.62971296001, 10744.946275268574, 9039.186473217442, 9182.219511341344, 9201.665758464851, 9257.768555786159, 9383.061693830563, 8589.355798315277, 8762.0, 8800.16398442147, 9000.414973026733, 9010.50442225684], "unit": "ms", "name": "yui.html", "value": 5647.522438626367}], "name": "dromaeo_css", "value": 6329.803990514056}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 114.0, 114.0, 115.0, 117.0, 123.0, 113.0, 113.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 161.0, 183.0, 130.0, 155.0, 156.0, 134.0, 172.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 164.0, 162.0, 164.0, 174.0, 165.0, 166.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 73.0, 73.0, 122.0, 72.0, 79.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 141.0, 94.0, 95.0, 94.0, 135.0, 95.0, 96.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 74.0, 77.0, 76.0, 76.0, 76.0, 75.0, 75.0], "unit": "ms", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 89.0, 87.0, 87.0, 88.0, 88.0, 95.0, 89.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [122.0, 118.0, 124.0, 126.0, 121.0, 121.0, 140.0, 122.0, 125.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 153.0, 159.0, 155.0, 143.0, 158.0, 153.0, 151.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 70.0, 72.0, 74.0, 71.0, 73.0, 69.0, 74.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1549.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.09583196586806], "unit": "score", "name": "Richards", "value": 215.13038799999993}, {"lowerIsBetter": false, "replicates": [185.59762435040832], "unit": "score", "name": "DeltaBlue", "value": 356.2437839999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [647.2491909385113], "unit": "score", "name": "Splay", "value": 125.90359500000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21257.31734076582}]} 22:56:57 INFO - RETURN: dromaeo_css: 6329.80 22:56:57 INFO - RETURN: kraken: 1549.10 22:56:57 INFO - RETURN: v8_7: 21257.32 22:56:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21257.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6329.80"}}} 22:56:57 INFO - Return code: 0 22:56:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:56:57 INFO - # TBPL SUCCESS # 22:56:57 INFO - Running post-action listener: _resource_record_post_action 22:56:57 INFO - Running post-run listener: _resource_record_post_run 22:56:58 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10682368; Write bytes: 401915904; Read time: 4152; Write time: 362252 22:56:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 7856128; Read time: 0; Write time: 620 22:56:58 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 10678272; Write bytes: 316633088; Read time: 4080; Write time: 282656 22:56:58 INFO - Running post-run listener: _upload_blobber_files 22:56:58 INFO - Blob upload gear active. 22:56:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:56:58 INFO - Copying logs to upload dir... 22:56:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.501773 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-11 22:56:58.863089) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:56:58.866612) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009995 build_url: 'https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:56:58.918816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:56:58.919166) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449899140.585532-2087076643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:56:58.968893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 22:56:58.969245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 22:56:58.969547) ========= ========= Total master_lag: 0.21 =========