builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1449902137.59 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.592680) ========= 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.593373) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.593713) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.636188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.636590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.713145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.713576) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.758479) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.758880) ========= 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.759361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.759737) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 22:35:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2015-12-11 22:35:38 (18.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.981275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:37.982056) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.033904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.034785) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 22:35:39,097 truncating revision to first 12 chars 2015-12-11 22:35:39,097 Setting DEBUG logging. 2015-12-11 22:35:39,097 attempt 1/10 2015-12-11 22:35:39,097 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,467 unpacking tar archive at: fx-team-6c24ecacc1a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.708532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.708881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.719315) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 22:35:38.719670) ========= 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:38.720188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-11 22:35:38.720564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 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 --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', 22:35:39 INFO - 'system_bits': '64', 22:35:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:35:39 INFO - 'title': 'talos-linux64-ix-064', 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:40 INFO - Running post-action listener: _resource_record_post_action 22:35:40 INFO - ##### 22:35:40 INFO - ##### Running read-buildbot-config step. 22:35:40 INFO - ##### 22:35:40 INFO - Running pre-action listener: _resource_record_pre_action 22:35:40 INFO - Running main action method: read_buildbot_config 22:35:40 INFO - Using buildbot properties: 22:35:40 INFO - { 22:35:40 INFO - "properties": { 22:35:40 INFO - "buildnumber": 2206, 22:35:40 INFO - "product": "firefox", 22:35:40 INFO - "script_repo_revision": "production", 22:35:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:35:40 INFO - "repository": "", 22:35:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:35:40 INFO - "buildid": "20151211213131", 22:35:40 INFO - "slavename": "talos-linux64-ix-064", 22:35:40 INFO - "pgo_build": "False", 22:35:40 INFO - "basedir": "/builds/slave/test", 22:35:40 INFO - "project": "", 22:35:40 INFO - "platform": "ubuntu64_hw", 22:35:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:35:40 INFO - "slavebuilddir": "test", 22:35:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:35:40 INFO - "branch": "fx-team", 22:35:40 INFO - "repo_path": "integration/fx-team", 22:35:40 INFO - "stage_platform": "linux64", 22:35:40 INFO - "builduid": "9d34c61704e44a82b3990521515adf3a", 22:35:40 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:40 INFO - }, 22:35:40 INFO - "sourcestamp": { 22:35:40 INFO - "repository": "", 22:35:40 INFO - "hasPatch": false, 22:35:40 INFO - "project": "", 22:35:40 INFO - "branch": "fx-team-linux64-talos", 22:35:40 INFO - "changes": [ 22:35:40 INFO - { 22:35:40 INFO - "category": null, 22:35:40 INFO - "files": [ 22:35:40 INFO - { 22:35:40 INFO - "url": null, 22:35:40 INFO - "name": "https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:35:40 INFO - } 22:35:40 INFO - ], 22:35:40 INFO - "repository": "", 22:35:40 INFO - "rev": "6c24ecacc1a9c5e9c054c074269f808d587ee29c", 22:35:40 INFO - "who": "philringnalda@gmail.com", 22:35:40 INFO - "when": 1449902117, 22:35:40 INFO - "number": 7354654, 22:35:40 INFO - "comments": "Merge m-c to f-t", 22:35:40 INFO - "project": "", 22:35:40 INFO - "at": "Fri 11 Dec 2015 22:35:17", 22:35:40 INFO - "branch": "fx-team-linux64-talos", 22:35:40 INFO - "revlink": "", 22:35:40 INFO - "properties": [ 22:35:40 INFO - [ 22:35:40 INFO - "buildid", 22:35:40 INFO - "20151211213131", 22:35:40 INFO - "Change" 22:35:40 INFO - ], 22:35:40 INFO - [ 22:35:40 INFO - "builduid", 22:35:40 INFO - "9d34c61704e44a82b3990521515adf3a", 22:35:40 INFO - "Change" 22:35:40 INFO - ], 22:35:40 INFO - [ 22:35:40 INFO - "pgo_build", 22:35:40 INFO - "False", 22:35:40 INFO - "Change" 22:35:40 INFO - ] 22:35:40 INFO - ], 22:35:40 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:40 INFO - } 22:35:40 INFO - ], 22:35:40 INFO - "revision": "6c24ecacc1a9c5e9c054c074269f808d587ee29c" 22:35:40 INFO - } 22:35:40 INFO - } 22:35:40 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:40 INFO - Running post-action listener: _resource_record_post_action 22:35:40 INFO - ##### 22:35:40 INFO - ##### Running download-and-extract step. 22:35:40 INFO - ##### 22:35:40 INFO - Running pre-action listener: _resource_record_pre_action 22:35:40 INFO - Running main action method: download_and_extract 22:35:40 INFO - mkdir: /builds/slave/test/build/tests 22:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:40 INFO - https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json 22:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/test_packages.json 22:35:40 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:40 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:55 INFO - Downloaded 21869874 bytes. 22:35:55 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:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:35:55 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:56 INFO - Return code: 0 22:35:56 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:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:56 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:56 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:56 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:56 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:56 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:36:00 INFO - Downloaded 21869874 bytes. 22:36:00 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:36:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:36:00 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:36:01 INFO - Return code: 0 22:36:01 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:01 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:36:01 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:36:01 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:36:01 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:36:01 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:36:02 INFO - Downloaded 11132038 bytes. 22:36:02 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:36:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:36:02 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:36:03 INFO - Return code: 0 22:36:03 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:03 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:36:03 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:36:03 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:36:03 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:36:03 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:36:04 INFO - Downloaded 57736563 bytes. 22:36:04 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:36:04 INFO - mkdir: /builds/slave/test/properties 22:36:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:36:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:36:04 INFO - Contents: 22:36:04 INFO - build_url:https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:36:04 INFO - Running post-action listener: _resource_record_post_action 22:36:04 INFO - Running post-action listener: set_extra_try_arguments 22:36:04 INFO - ##### 22:36:04 INFO - ##### Running populate-webroot step. 22:36:04 INFO - ##### 22:36:04 INFO - Running pre-action listener: _resource_record_pre_action 22:36:04 INFO - Running main action method: populate_webroot 22:36:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:36:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:36:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:36:04 INFO - '--tppagecycles', 22:36:04 INFO - '7'], 22:36:04 INFO - 'tests': ['tsvgm']}}, 22:36:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:36:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:36:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:36:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:36:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'tests': ['damp', 'tps']}, 22:36:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['damp', 'tps']}, 22:36:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:36:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:36:04 INFO - 'other': {'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'other_l64': {'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'other_nol64': {'tests': ['a11yr', 22:36:04 INFO - 'ts_paint', 22:36:04 INFO - 'tpaint', 22:36:04 INFO - 'sessionrestore', 22:36:04 INFO - 'sessionrestore_no_auto_restore']}, 22:36:04 INFO - 'svgr': {'tests': ['tsvgx', 22:36:04 INFO - 'tsvgr_opacity', 22:36:04 INFO - 'tart', 22:36:04 INFO - 'tscrollx', 22:36:04 INFO - 'cart']}, 22:36:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['tsvgx', 22:36:04 INFO - 'tsvgr_opacity', 22:36:04 INFO - 'tart', 22:36:04 INFO - 'tscrollx', 22:36:04 INFO - 'cart']}, 22:36:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'tests': ['tp5o']}, 22:36:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'talos_options': ['--e10s'], 22:36:04 INFO - 'tests': ['tp5o']}, 22:36:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'talos_options': ['--xperf_path', 22:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:04 INFO - 'tests': ['tp5n']}, 22:36:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:04 INFO - 'talos_options': ['--e10s', 22:36:04 INFO - '--xperf_path', 22:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:04 INFO - 'tests': ['tp5n']}}, 22:36:04 INFO - 'talos.zip': {'path': '', 22:36:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:36:04 INFO - Running post-action listener: _resource_record_post_action 22:36:04 INFO - ##### 22:36:04 INFO - ##### Running create-virtualenv step. 22:36:04 INFO - ##### 22:36:04 INFO - Running pre-action listener: _resource_record_pre_action 22:36:04 INFO - Running main action method: create_virtualenv 22:36:04 INFO - Creating virtualenv /builds/slave/test/build/venv 22:36:04 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:36:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:36:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:36:04 INFO - Using real prefix '/usr' 22:36:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:36:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:36:07 INFO - Installing pip.................done. 22:36:07 INFO - Return code: 0 22:36:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:36:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:07 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:07 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:36:07 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:36:07 INFO - Using env: {'DISPLAY': ':0', 22:36:07 INFO - 'HOME': '/home/cltbld', 22:36:07 INFO - 'LANG': 'en_US.UTF-8', 22:36:07 INFO - 'LANGUAGE': 'en_US:en', 22:36:07 INFO - 'LOGNAME': 'cltbld', 22:36:07 INFO - 'MAIL': '/var/mail/cltbld', 22:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:07 INFO - 'MOZ_NO_REMOTE': '1', 22:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:07 INFO - 'NO_EM_RESTART': '1', 22:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:07 INFO - 'PWD': '/builds/slave/test', 22:36:07 INFO - 'SHELL': '/bin/bash', 22:36:07 INFO - 'SHLVL': '1', 22:36:07 INFO - 'TERM': 'linux', 22:36:07 INFO - 'TMOUT': '86400', 22:36:07 INFO - 'USER': 'cltbld', 22:36:07 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:07 INFO - '_': '/tools/buildbot/bin/python'} 22:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:07 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:07 INFO - Cleaning up... 22:36:07 INFO - Return code: 0 22:36:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:36:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:07 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 22:36:07 INFO - 'HOME': '/home/cltbld', 22:36:07 INFO - 'LANG': 'en_US.UTF-8', 22:36:07 INFO - 'LANGUAGE': 'en_US:en', 22:36:07 INFO - 'LOGNAME': 'cltbld', 22:36:07 INFO - 'MAIL': '/var/mail/cltbld', 22:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:07 INFO - 'MOZ_NO_REMOTE': '1', 22:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:07 INFO - 'NO_EM_RESTART': '1', 22:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:07 INFO - 'PWD': '/builds/slave/test', 22:36:07 INFO - 'SHELL': '/bin/bash', 22:36:07 INFO - 'SHLVL': '1', 22:36:07 INFO - 'TERM': 'linux', 22:36:07 INFO - 'TMOUT': '86400', 22:36:07 INFO - 'USER': 'cltbld', 22:36:07 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:07 INFO - '_': '/tools/buildbot/bin/python'} 22:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:07 INFO - Downloading/unpacking psutil>=0.7.1 22:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:36:09 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:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:36:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:09 INFO - Installing collected packages: psutil 22:36:09 INFO - Running setup.py install for psutil 22:36:09 INFO - building 'psutil._psutil_linux' extension 22:36:09 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:09 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:09 INFO - building 'psutil._psutil_posix' extension 22:36:09 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:09 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:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:09 INFO - Successfully installed psutil 22:36:09 INFO - Cleaning up... 22:36:09 INFO - Return code: 0 22:36:09 INFO - Installing mozsystemmonitor==0.0.0 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', '--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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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', '--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:09 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: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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:09 INFO - '_': '/tools/buildbot/bin/python'} 22:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:36:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:36:11 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:11 INFO - Installing collected packages: mozsystemmonitor 22:36:11 INFO - Running setup.py install for mozsystemmonitor 22:36:11 INFO - Successfully installed mozsystemmonitor 22:36:11 INFO - Cleaning up... 22:36:11 INFO - Return code: 0 22:36:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:36:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:11 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 22:36:11 INFO - 'HOME': '/home/cltbld', 22:36:11 INFO - 'LANG': 'en_US.UTF-8', 22:36:11 INFO - 'LANGUAGE': 'en_US:en', 22:36:11 INFO - 'LOGNAME': 'cltbld', 22:36:11 INFO - 'MAIL': '/var/mail/cltbld', 22:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:11 INFO - 'MOZ_NO_REMOTE': '1', 22:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:11 INFO - 'NO_EM_RESTART': '1', 22:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:11 INFO - 'PWD': '/builds/slave/test', 22:36:11 INFO - 'SHELL': '/bin/bash', 22:36:11 INFO - 'SHLVL': '1', 22:36:11 INFO - 'TERM': 'linux', 22:36:11 INFO - 'TMOUT': '86400', 22:36:11 INFO - 'USER': 'cltbld', 22:36:11 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:11 INFO - '_': '/tools/buildbot/bin/python'} 22:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:36:12 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:12 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:12 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:12 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:12 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:12 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:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:36:13 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:36:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:36:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:14 INFO - Downloading docopt-0.6.1.tar.gz 22:36:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:36:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:36:14 INFO - Running setup.py install for blobuploader 22:36:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:36:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:36:14 INFO - Running setup.py install for requests 22:36:15 INFO - Running setup.py install for docopt 22:36:15 INFO - Successfully installed blobuploader requests docopt 22:36:15 INFO - Cleaning up... 22:36:15 INFO - Return code: 0 22:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:15 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 22:36:15 INFO - 'HOME': '/home/cltbld', 22:36:15 INFO - 'LANG': 'en_US.UTF-8', 22:36:15 INFO - 'LANGUAGE': 'en_US:en', 22:36:15 INFO - 'LOGNAME': 'cltbld', 22:36:15 INFO - 'MAIL': '/var/mail/cltbld', 22:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:15 INFO - 'MOZ_NO_REMOTE': '1', 22:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:15 INFO - 'NO_EM_RESTART': '1', 22:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:15 INFO - 'PWD': '/builds/slave/test', 22:36:15 INFO - 'SHELL': '/bin/bash', 22:36:15 INFO - 'SHLVL': '1', 22:36:15 INFO - 'TERM': 'linux', 22:36:15 INFO - 'TMOUT': '86400', 22:36:15 INFO - 'USER': 'cltbld', 22:36:15 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:15 INFO - '_': '/tools/buildbot/bin/python'} 22:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:15 INFO - Running setup.py (path:/tmp/pip-bHTgFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:15 INFO - Running setup.py (path:/tmp/pip-FqRZ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:15 INFO - Running setup.py (path:/tmp/pip-LZkefJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:15 INFO - Running setup.py (path:/tmp/pip-hefPvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:15 INFO - Running setup.py (path:/tmp/pip-Ep_VZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:15 INFO - Running setup.py (path:/tmp/pip-hDKdV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:15 INFO - Running setup.py (path:/tmp/pip-z0OaB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:15 INFO - Running setup.py (path:/tmp/pip-S0eAUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:16 INFO - Running setup.py (path:/tmp/pip-sz43Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:16 INFO - Running setup.py (path:/tmp/pip-hv7FrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:16 INFO - Running setup.py (path:/tmp/pip-3paBB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:16 INFO - Running setup.py (path:/tmp/pip-rpspxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:16 INFO - Running setup.py (path:/tmp/pip-j_Ulw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:16 INFO - Running setup.py (path:/tmp/pip-Q1mvAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:16 INFO - Running setup.py (path:/tmp/pip-1hai5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:16 INFO - Running setup.py (path:/tmp/pip-Xo5FxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:16 INFO - Running setup.py (path:/tmp/pip-F5BkFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:36:16 INFO - Running setup.py install for manifestparser 22:36:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:36:16 INFO - Running setup.py install for mozcrash 22:36:16 INFO - Running setup.py install for mozdebug 22:36:16 INFO - Running setup.py install for mozdevice 22:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for mozfile 22:36:17 INFO - Running setup.py install for mozhttpd 22:36:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for mozinfo 22:36:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for mozInstall 22:36:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for mozleak 22:36:17 INFO - Running setup.py install for mozlog 22:36:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for moznetwork 22:36:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:36:17 INFO - Running setup.py install for mozprocess 22:36:17 INFO - Running setup.py install for mozprofile 22:36:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:36:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:36:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:36:18 INFO - Running setup.py install for mozrunner 22:36:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:36:18 INFO - Running setup.py install for mozscreenshot 22:36:18 INFO - Running setup.py install for moztest 22:36:18 INFO - Running setup.py install for mozversion 22:36:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:36:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:36:18 INFO - Cleaning up... 22:36:18 INFO - Return code: 0 22:36:18 INFO - Installing None 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', '-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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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', '-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:18 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: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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:18 INFO - '_': '/tools/buildbot/bin/python'} 22:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:18 INFO - Running setup.py (path:/tmp/pip-njUMaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:18 INFO - Running setup.py (path:/tmp/pip-HPZnnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:18 INFO - Running setup.py (path:/tmp/pip-nXma_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:18 INFO - Running setup.py (path:/tmp/pip-Hi6TpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:18 INFO - Running setup.py (path:/tmp/pip-iwtq6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:19 INFO - Running setup.py (path:/tmp/pip-vqBtxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:19 INFO - Running setup.py (path:/tmp/pip-YJYJFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:19 INFO - Running setup.py (path:/tmp/pip-_1U6rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:19 INFO - Running setup.py (path:/tmp/pip-1AKyeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:19 INFO - Running setup.py (path:/tmp/pip-ohd49x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:19 INFO - Running setup.py (path:/tmp/pip-dm86_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:19 INFO - Running setup.py (path:/tmp/pip-xanpvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:19 INFO - Running setup.py (path:/tmp/pip-JnTmPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:19 INFO - Running setup.py (path:/tmp/pip-Kow9oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:19 INFO - Running setup.py (path:/tmp/pip-JaiJfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:19 INFO - Running setup.py (path:/tmp/pip-QPbJ_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:19 INFO - Running setup.py (path:/tmp/pip-RodvH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:21 INFO - Downloading blessings-1.5.1.tar.gz 22:36:21 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:36:21 INFO - Installing collected packages: blessings 22:36:21 INFO - Running setup.py install for blessings 22:36:21 INFO - Successfully installed blessings 22:36:21 INFO - Cleaning up... 22:36:21 INFO - Return code: 0 22:36:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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:22 INFO - Reading from file tmpfile_stdout 22:36:22 INFO - Current package versions: 22:36:22 INFO - argparse == 1.2.1 22:36:22 INFO - blessings == 1.5.1 22:36:22 INFO - blobuploader == 1.2.4 22:36:22 INFO - docopt == 0.6.1 22:36:22 INFO - manifestparser == 1.1 22:36:22 INFO - mozInstall == 1.12 22:36:22 INFO - mozcrash == 0.16 22:36:22 INFO - mozdebug == 0.1 22:36:22 INFO - mozdevice == 0.47 22:36:22 INFO - mozfile == 1.2 22:36:22 INFO - mozhttpd == 0.7 22:36:22 INFO - mozinfo == 0.9 22:36:22 INFO - mozleak == 0.1 22:36:22 INFO - mozlog == 3.1 22:36:22 INFO - moznetwork == 0.27 22:36:22 INFO - mozprocess == 0.22 22:36:22 INFO - mozprofile == 0.27 22:36:22 INFO - mozrunner == 6.11 22:36:22 INFO - mozscreenshot == 0.1 22:36:22 INFO - mozsystemmonitor == 0.0 22:36:22 INFO - moztest == 0.7 22:36:22 INFO - mozversion == 1.4 22:36:22 INFO - psutil == 3.1.1 22:36:22 INFO - requests == 1.2.3 22:36:22 INFO - wsgiref == 0.1.2 22:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:22 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 22:36:22 INFO - 'HOME': '/home/cltbld', 22:36:22 INFO - 'LANG': 'en_US.UTF-8', 22:36:22 INFO - 'LANGUAGE': 'en_US:en', 22:36:22 INFO - 'LOGNAME': 'cltbld', 22:36:22 INFO - 'MAIL': '/var/mail/cltbld', 22:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:22 INFO - 'MOZ_NO_REMOTE': '1', 22:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:22 INFO - 'NO_EM_RESTART': '1', 22:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:22 INFO - 'PWD': '/builds/slave/test', 22:36:22 INFO - 'SHELL': '/bin/bash', 22:36:22 INFO - 'SHLVL': '1', 22:36:22 INFO - 'TERM': 'linux', 22:36:22 INFO - 'TMOUT': '86400', 22:36:22 INFO - 'USER': 'cltbld', 22:36:22 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:22 INFO - '_': '/tools/buildbot/bin/python'} 22:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Cleaning up... 22:36:22 INFO - Return code: 0 22:36:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:22 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 22:36:22 INFO - 'HOME': '/home/cltbld', 22:36:22 INFO - 'LANG': 'en_US.UTF-8', 22:36:22 INFO - 'LANGUAGE': 'en_US:en', 22:36:22 INFO - 'LOGNAME': 'cltbld', 22:36:22 INFO - 'MAIL': '/var/mail/cltbld', 22:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:22 INFO - 'MOZ_NO_REMOTE': '1', 22:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:22 INFO - 'NO_EM_RESTART': '1', 22:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:22 INFO - 'PWD': '/builds/slave/test', 22:36:22 INFO - 'SHELL': '/bin/bash', 22:36:22 INFO - 'SHLVL': '1', 22:36:22 INFO - 'TERM': 'linux', 22:36:22 INFO - 'TMOUT': '86400', 22:36:22 INFO - 'USER': 'cltbld', 22:36:22 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:22 INFO - '_': '/tools/buildbot/bin/python'} 22:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:22 INFO - Downloading/unpacking jsonschema 22:36:22 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:22 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:22 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:22 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:22 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:22 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:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:36:24 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:24 INFO - Downloading/unpacking functools32 (from jsonschema) 22:36:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading functools32-3.2.3-2.tar.gz 22:36:24 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:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:36:24 INFO - warning: no files found matching '*.txt' 22:36:24 INFO - no previously-included directories found matching 'build' 22:36:24 INFO - no previously-included directories found matching 'dist' 22:36:24 INFO - no previously-included directories found matching '.git*' 22:36:24 INFO - Installing collected packages: jsonschema, functools32 22:36:24 INFO - Running setup.py install for functools32 22:36:24 INFO - warning: no files found matching '*.txt' 22:36:24 INFO - no previously-included directories found matching 'build' 22:36:24 INFO - no previously-included directories found matching 'dist' 22:36:24 INFO - no previously-included directories found matching '.git*' 22:36:24 INFO - Successfully installed jsonschema functools32 22:36:24 INFO - Cleaning up... 22:36:24 INFO - Return code: 0 22:36:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:36:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:24 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 0x7f723d4b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 22:36:24 INFO - 'HOME': '/home/cltbld', 22:36:24 INFO - 'LANG': 'en_US.UTF-8', 22:36:24 INFO - 'LANGUAGE': 'en_US:en', 22:36:24 INFO - 'LOGNAME': 'cltbld', 22:36:24 INFO - 'MAIL': '/var/mail/cltbld', 22:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:24 INFO - 'MOZ_NO_REMOTE': '1', 22:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:24 INFO - 'NO_EM_RESTART': '1', 22:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:24 INFO - 'PWD': '/builds/slave/test', 22:36:24 INFO - 'SHELL': '/bin/bash', 22:36:24 INFO - 'SHLVL': '1', 22:36:24 INFO - 'TERM': 'linux', 22:36:24 INFO - 'TMOUT': '86400', 22:36:24 INFO - 'USER': 'cltbld', 22:36:24 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:24 INFO - '_': '/tools/buildbot/bin/python'} 22:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:24 INFO - Downloading/unpacking flake8 22:36:24 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:24 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:24 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:24 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:24 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:24 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:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:36:26 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:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:36:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:36:26 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:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:36:26 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:26 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:26 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:26 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:26 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:26 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:26 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:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:27 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:27 INFO - no previously-included directories found matching 'docs/_build' 22:36:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:36:27 INFO - Running setup.py install for pep8 22:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:27 INFO - no previously-included directories found matching 'docs/_build' 22:36:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:36:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:36:27 INFO - Cleaning up... 22:36:27 INFO - Return code: 0 22:36:27 INFO - Running post-action listener: _resource_record_post_action 22:36:27 INFO - Running post-action listener: _start_resource_monitoring 22:36:27 INFO - Starting resource monitoring. 22:36:27 INFO - ##### 22:36:27 INFO - ##### Running install step. 22:36:27 INFO - ##### 22:36:27 INFO - Running pre-action listener: _resource_record_pre_action 22:36:27 INFO - Running main action method: install 22:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:36:27 INFO - Reading from file tmpfile_stdout 22:36:27 INFO - Detecting whether we're running mozinstall >=1.0... 22:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:36:27 INFO - Reading from file tmpfile_stdout 22:36:27 INFO - Output received: 22:36:27 INFO - Usage: mozinstall [options] installer 22:36:27 INFO - Options: 22:36:27 INFO - -h, --help show this help message and exit 22:36:27 INFO - -d DEST, --destination=DEST 22:36:27 INFO - Directory to install application into. [default: 22:36:27 INFO - "/builds/slave/test"] 22:36:27 INFO - --app=APP Application being installed. [default: firefox] 22:36:27 INFO - mkdir: /builds/slave/test/build/application 22:36:27 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:27 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:42 INFO - Reading from file tmpfile_stdout 22:36:42 INFO - Output received: 22:36:42 INFO - /builds/slave/test/build/application/firefox/firefox 22:36:42 INFO - Running post-action listener: _resource_record_post_action 22:36:42 INFO - ##### 22:36:42 INFO - ##### Running run-tests step. 22:36:42 INFO - ##### 22:36:42 INFO - Running pre-action listener: _resource_record_pre_action 22:36:42 INFO - Running main action method: run_tests 22:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:36:42 INFO - Python 2.7.3 22:36:42 INFO - Return code: 0 22:36:42 INFO - grabbing minidump binary from tooltool 22:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:42 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 0x1c1a0b0>, '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 0x1c1afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:36:42 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:42 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:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:36:42 INFO - Return code: 0 22:36:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:36:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:36:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:36:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:36:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:36:43 INFO - Return code: 0 22:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] in /builds/slave/test/build 22:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost 22:36:43 INFO - Using env: {'DISPLAY': ':0', 22:36:43 INFO - 'HOME': '/home/cltbld', 22:36:43 INFO - 'LANG': 'en_US.UTF-8', 22:36:43 INFO - 'LANGUAGE': 'en_US:en', 22:36:43 INFO - 'LOGNAME': 'cltbld', 22:36:43 INFO - 'MAIL': '/var/mail/cltbld', 22:36:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:36:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:43 INFO - 'MOZ_NO_REMOTE': '1', 22:36:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:43 INFO - 'NO_EM_RESTART': '1', 22:36:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:43 INFO - 'PWD': '/builds/slave/test', 22:36:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:36:43 INFO - 'SHELL': '/bin/bash', 22:36:43 INFO - 'SHLVL': '1', 22:36:43 INFO - 'TERM': 'linux', 22:36:43 INFO - 'TMOUT': '86400', 22:36:43 INFO - 'USER': 'cltbld', 22:36:43 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738', 22:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:43 INFO - '_': '/tools/buildbot/bin/python'} 22:36:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Qcv8VCLS0CaFFIRLE4dCQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] with output_timeout 3600 22:36:43 INFO - mozversion INFO | application_buildid: 20151211213131 22:36:43 INFO - mozversion INFO | application_changeset: 6c24ecacc1a9c5e9c054c074269f808d587ee29c 22:36:43 INFO - mozversion INFO | application_display_name: Nightly 22:36:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:36:43 INFO - mozversion INFO | application_name: Firefox 22:36:43 INFO - mozversion INFO | application_remotingname: firefox 22:36:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:36:43 INFO - mozversion INFO | application_vendor: Mozilla 22:36:43 INFO - mozversion INFO | application_version: 45.0a1 22:36:43 INFO - mozversion INFO | platform_buildid: 20151211213131 22:36:43 INFO - mozversion INFO | platform_changeset: 6c24ecacc1a9c5e9c054c074269f808d587ee29c 22:36:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:36:43 INFO - mozversion INFO | platform_version: 45.0a1 22:36:43 INFO - 2015-12-11 22:36:43,551 DEBUG : using testdate: 1449902203 22:36:43 INFO - 2015-12-11 22:36:43,551 DEBUG : actual date: 1449902203 22:36:43 INFO - 2015-12-11 22:36:43,560 INFO : starting webserver on 'localhost:39330' 22:36:43 INFO - 2015-12-11 22:36:43,561 INFO : Starting test suite talos-linux64-ix-064 22:36:43 INFO - 2015-12-11 22:36:43,561 INFO : Starting test dromaeo_css 22:36:43 INFO - 2015-12-11 22:36:43,561 DEBUG : operating with platform_type : linux_ 22:36:43 INFO - 2015-12-11 22:36:43,562 INFO : Initialising browser for dromaeo_css test... 22:36:43 INFO - 2015-12-11 22:36:43,577 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVGObnF/profile http://localhost:39330/getInfo.html 22:36:47 INFO - 2015-12-11 22:36:47,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:47 INFO - 2015-12-11 22:36:47,617 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:47 INFO - 2015-12-11 22:36:47,618 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:36:47 INFO - 2015-12-11 22:36:47,618 DEBUG : BROWSER_OUTPUT: __metrics 22:36:47 INFO - 2015-12-11 22:36:47,767 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:47 INFO - 2015-12-11 22:36:47,829 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:48 INFO - 2015-12-11 22:36:48,896 INFO : Browser initialized. 22:36:48 INFO - 2015-12-11 22:36:48,897 INFO : Running cycle 1/1 for dromaeo_css test... 22:36:48 INFO - 2015-12-11 22:36:48,897 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVGObnF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:37:00 INFO - 2015-12-11 22:37:00,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 142925824 22:37:00 INFO - 2015-12-11 22:37:00,857 DEBUG : BROWSER_OUTPUT: 22:37:52 INFO - 2015-12-11 22:37:52,215 DEBUG : BROWSER_OUTPUT: 1449902272213 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:40:04 INFO - 2015-12-11 22:40:04,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39330/tests/dromaeo/cssquery-ext.html) 22:40:05 INFO - 2015-12-11 22:40:05,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 242827264 22:40:05 INFO - 2015-12-11 22:40:05,218 DEBUG : BROWSER_OUTPUT: 22:43:07 INFO - 2015-12-11 22:43:07,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-ext.html (next: http://localhost:39330/tests/dromaeo/cssquery-jquery.html) 22:43:08 INFO - 2015-12-11 22:43:08,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 218189824 22:43:08 INFO - 2015-12-11 22:43:08,259 DEBUG : BROWSER_OUTPUT: 22:46:10 INFO - 2015-12-11 22:46:10,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39330/tests/dromaeo/cssquery-mootools.html) 22:46:10 INFO - 2015-12-11 22:46:10,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 218124288 22:46:10 INFO - 2015-12-11 22:46:10,926 DEBUG : BROWSER_OUTPUT: 22:49:12 INFO - 2015-12-11 22:49:12,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39330/tests/dromaeo/cssquery-prototype.html) 22:49:13 INFO - 2015-12-11 22:49:13,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 204738560 22:49:13 INFO - 2015-12-11 22:49:13,456 DEBUG : BROWSER_OUTPUT: 22:52:16 INFO - 2015-12-11 22:52:16,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39330/tests/dromaeo/cssquery-yui.html) 22:52:16 INFO - 2015-12-11 22:52:16,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 208846848 22:52:16 INFO - 2015-12-11 22:52:16,729 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/dromaeo/cssquery-yui.html (next: http://localhost:39330/tests/dromaeo/cssquery-dojo.html) 22:55:19 INFO - 2015-12-11 22:55:19,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 250458112 22:55:19 INFO - 2015-12-11 22:55:19,341 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,342 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:55:19 INFO - 2015-12-11 22:55:19,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:55:19 INFO - 2015-12-11 22:55:19,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:55:19 INFO - 2015-12-11 22:55:19,342 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:55:19 INFO - 2015-12-11 22:55:19,343 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.8425694458333;2713.3081064328594;2713.4573085382926;2715.0497325935926;2725.4957832800933;4444.79998400072;4554.339620754989;4729.077829823182;4753;4775.235962246037;4600.907981840362;4665.276882083274;4760.190767569513;4770;4791.592714619253;4338.891527711801;4343.109662519184;4355.847545335914;4409.713368631044;4409.977950110245;4382.364557139213;4518.412606361168;4521.796519156629;4536.160810250098;4537.659675524349;4218.261804184255;4265.360195970598;4323.135372925396;4453.6659750518675;4472.865814025552;4396.582324679151;4420.889477763049;4426.380306757057;4441.777911104464;4443.977780111111;4383.517813040563;4385.8245670173155;4386.736795792231;4423.424954755861;4425.889352766175;4476;4590.540945905416;4667.22990706533;4670.556297151799;4697.412823397075;4924.113659541281;4962.776675049631;5040.395152581714;5041.143005689041;5052.494750524918;5160.174372100446;5165.66423182492;5169.224616307546;5184.507471790174;5190.143626301656;4764.976175119103;4785.784639691222;4789.712617242907;4790.664653474293;4837.467878533358;4880.853574392703;5039.974800125976;5044.672096313801;5170.689758614495;5272;4995.850124496271;5022.42242142151;5026.54761071498;5027.949720502748;5033.899322013539;5114.820981265712;5115.335006449212;5117.078925793393;5121.4622464641425;5149.948500515022;4786.7845946932475;4856.68431551955;4875.390576177978;4878.121938051185;4975.975120124449;5081.618878584121;5108.565771909355;5108.923366149511;5112.616553758408;5169.586433085344;4251.489821221473;4271.31658934569;4272.658187345067;4276.2302785498905;4278.2085314216965;3565.16218688608;3645;3661;3667.339878821838;3728.179800443898;4353.717008394444;4365.236083685342;4367.344898265222;4381.627561657231;4412.580804823537;5036.496350365008;5046.1169295373165;5048.444671086178;5051.292819005343;5089.949100509021;4182.226288136704;4265.0616864289805;4281.571842815693;4348.673849461303;4456.442944631921;4449.488308844524;4458.308962110878;4460.264056430653;4461.598456138963;4485.147821913891;4782.115308667908;4785.090832741768;4787.305840653155;4789.353437285922;4830.516948305141;4841.1285968526;4977.701337919736;4980.676256043345;5107.336046313955;5237.319148510669;4858.854234372974;4872.074305881871;4875.6099512038245;4878.414590249193;4913.680610760289;5049.394072711151;5051.343325367826;5056.595472362275;5057.519535644108;5099.26060721186;4840.443349014768;4967.279744437109;4969.527894849984;4974.403071631427;5071.619628527801;4941.184704523714;4964.975175124101;4975.502449754996;4977.626677999092;5014;4943.530364615356;4948.604111671129;4949.430815456269;4951.455339912534;5001.449840517613;4640.350350950802;4760.190767569452;4763.380760501252;4805.087033463631;4905.852824415273;5000.974995125001;5006.098902197494;5010.348654674869;5030.4466508684745;5041;4892.68197567157;4892.828750993698;4900.313956046085;4900.730459824744;4904.4605093440405 22:55:19 INFO - 2015-12-11 22:55:19,344 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.9937078437449;558.1042426904818;566.8894565559713;579.8985177593921;588.182426427266;26210.344741381476;26806.927722891087;26807.329816754544;26839.463210735797;26847.731522684768;27309.726902730967;27762.30594235145;35205.82397088017;35859.820700896526;35912.46131308033;7923.6038198090155;8088;8105.230003149692;8108.391870609698;8113.229243221914;7192.388646965014;7880.724174653888;7932.8810067848735;7975.7607271781935;7995;7160.85678286434;10255.333403328797;10532.842007369896;10538.68383948479;10559.841602375971;10074.445905475195;10094.79810403795;10184.74538136545;10195.949020254926;10199.592016319339;7219.530730502501;7449.590272535009;9944.801103977952;10140;10180.847287290697;36261;36710.63289367099;36746;36761;36811.07972300687;2906.287959449948;2909.418116376712;2945.7054294570585;2965.54034124711;2977.702229777027;28328.433431331257;28571;28642.42715145706;28708.425831483462;28745.425091498262;3456.4296891012955;3555.982220088909;3567.4827150063097;3605.405108157151;3621.7102631789658;212345;214985;215060;215926;216816;55571;56003.87943748134;56016.159757603666;56053.439465604824;56235.43764562384;60242.39757602455;60432;60540.69729651412;60557.69721151366;60571.09143362853;12507.812382814265;12611.873881261254;12633.620991370273;12636.30500322491;12648.810267845989;9951.353162044588;9984.400935943866;9987.800243995225;10005.699829005142;10016;19303.903480482506;19548.804511954982;19608;19636.509087272934;19654.70517942232;7777.377809775205;7814.765557033184;8028.357731381476;8106.675732970615;8108.270255677017;839.4040231435627;919.6275508418967;953.0755167487526;1022.0750221049962;1032.0969151992008;25939.92837690938;26399.208023759318;26418.339541511617;26513.734862651127;26592.468150637265;794.2018271636967;880.1638443478721;913.6482454255159;969.9321047526746;1046.4401545173296;12087.87912120885;12543.623691289276;12563.309018003914;12973.156744811557;13171.538996135281;249059;252056;252413;252723;253750;41688.79155604202;42831;44449.55550444454;44766.32850507245;44795.55204447914;1190.6725650446197;1195.5277665322149;1198.2391181599746;1205.0961778665826;1208.6796998795326;24422.389440264134;24487.97996410696;25107.372315692253;25801.870990644926;29108.417831642826;40036;40337.79831100826;40387.3941890866;40453.1909361817;40454.393184101675;189297;190350;190707;190739;191007;29065.854670727356;29715.851420742758;29752;41561.58438415577;42224.19982201617;37351;37421.4386784193;38276.6172338273;38345.233095338495;38660;32891.50662740013;32965.67034329626;33165.834170829956;33563;33644;39678.801605991786;40990.59009409987;41232.58767412287;41398;42268.577314226466;36154;36242.27515449729;36656.633433666386;36752;37169.25661486809;36045.27909441849;36729.63270367262;36798.44802328021;37009.259814803016;37076;27848.16455506338;28899.7110028897;28900.710992889803;28937.421251575273;29209.415811684074 22:55:19 INFO - 2015-12-11 22:55:19,345 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.4222326482128;327.8360819590205;330.1893850596785;331.73295497124815;332.42988275108183;12463.376831158452;12735.426905789238;14731.189784561844;15185.240737963099;15281.541553753392;14903.180325082116;15043.849561504381;15051.774223386657;15061.698766024672;15250.237488125576;4954.08349455351;4997.675151115184;5000.699958002531;5011.32347133136;5016.548510634042;3737.1591391936868;3832.7891965941863;4999.275105109757;5582.771790206169;5769.509591684712;5520.530754885839;5692.0608099663505;5699.430056994288;5728.828135155931;5731.226284451608;5671.376148623648;5695.914561281584;5700.543956483471;5705.828825135231;5708.286464191976;4941.061198372297;5018.146915024455;5019.171836646949;5021.895183059721;5033.1695270280725;18998.71501927472;19288.324908628132;19418.029098545016;19467.31864384754;19493.512662183417;1859.7024476083898;1926.566522532433;2003.3188715836686;2040.0513761101158;2042.3362407217564;12442.17578561182;12511.874881251162;12702.42839072244;12827.743445131046;13072.542461013818;1746.8777185597014;1754.1843042984945;1766.3994241957796;1789.9910500447545;1823.088455772114;52328;57811.710941445446;58058;58408.70795646037;59279;9074.637014519478;9089.091090890857;9136.6802161924;9178.724638260863;9256.72229833106;11203.887961120448;11216.158788090926;11219;11222.382768947786;11232.157588180919;6539.346065393423;6568.146141001735;6693.631850248185;6716.395524402729;6724.529282950147;6563.50773691975;6565.606063636197;6575.309592492815;6618.86762264752;6625.204975402886;3625.9818700906326;3678.8528458861883;3682.0794801299676;3699.852005919733;3702.259548090393;1605.4621701729818;1646.6706658668313;1651.5458248981627;1702.3360889253202;1714.802797678258;814.608987685914;920.802027564077;921.9815603687889;943.9528023598792;982.9655962041294;12558.81161782574;15656.217189140498;15673.529794106194;15969.44106956251;16286.348546058025;829.2785276809215;835.07723965019;848.3510114762212;851.7870532366908;861.2033868671579;8671;8746.69386571467;8912.73261802134;8917.331200159884;9029.77425564366;431070;434096;439433;442024;444141;69237;72727.27272727311;72861.6356918212;73118.26881731222;74046.62976685082;1034.0590063042596;1040.0795296162798;1046.1212581431635;1047.7799662070897;1048.570086264628;13649.590512284647;14211.218382988622;14290.78528325104;14486.492972745904;14752.704945900807;30037.54943675803;30923.493332671333;33539.66460335365;34593.65406345904;35429.46855797217;42913.267754318316;43544.34683479687;45388.77305613451;47868.76065619649;51117.23324150066;8839.823203536022;8999.100089990949;9180.632774688938;9236.30727695439;9253.67612133572;15522.689546208787;15650.608734781721;15687.529374118794;16724.414645487348;16735.24691388866;13885.583432497042;14261.643458913195;14351.210683412513;14415.279236038366;14519.419223230952;12791.95328747396;13402.93298533501;13457.259850707913;13646.795298070736;13998;10688.25182237236;10753.354798712102;11064.114870810477;13768.931155344158;14280;7964.6415911282975;8352.6241319142;8470.32237421017;8837.469751814911;8858.64565417376;9841.507924603884;13321.800172997218;13679.726405472034;13703.862961370658;13748.65628359299 22:55:19 INFO - 2015-12-11 22:55:19,348 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1388.0838646493316;1650.9752353714694;1676.9077700726464;1712.2380540659403;1718.9914050429745;5702.942970570293;6425;6611.206655201383;6624.536282460223;6625.768098116567;6730.932690673092;6868.896966545493;6885.552439091455;6895.103636527245;6896.310368963102;1719.1318384215954;1742.120229284216;1745.7381392791056;2009.6884982827648;2045.0694933805157;1722.4832550234942;1730.0657644871817;2008.3071340387544;2040.1737296394983;2051.52814852584;2011.8893460859647;2015.2039944222024;2016.84873634478;2017.4855411870026;2018.374303965768;1970.3005433071269;2031.5632139090167;2032.7662318833375;2034.2778313698645;2035.1248962945926;2001.8698784578955;2011.9195232190696;2037.9796202037937;2066.4730493724155;2066.95866082679;6825.48808839339;6895.931040689579;6896.310368963063;6898.379145876845;6902.758403455855;4092.9590704092875;4115.156392939441;4150.896227594304;4153.314703073989;4185.2885009548145;2532.113760183939;2562.6796650418696;2591.5853463445947;2594.545954457981;2604.322876052221;797.3063434811693;818.9262966332999;819.0539926385035;821.9712310069178;835.5696816139692;9223.815523689556;9229.21551668109;9241.861372079424;9242.399244049115;9244.676436324697;3761.153740408386;3765.3410653135593;3804.4863943367845;3860.536735591691;3861.2856621525107;8044.31623312025;8047.356211503065;8051.758447246592;8057.153998830038;8058.556779377073;4068.2880495913096;4087.7547347159266;4088.509378874495;4093.692973027035;4096.795160241976;3721.981390093032;3725.0501122214205;3728.757630753992;3729.254149170177;3732.309522738302;3328.6338502764675;3349.581302337208;3356.16095976006;3404.1149301181376;3409.0113866978795;920.2362039507193;946.9479178645103;1005.8038682456851;1068.4444089073638;1068.7488440216543;850.9234168924827;858.914108589136;859.0764927702744;902.7517432706059;1030.3199888073834;6220.595661282002;6263.749450022039;6273.905891411632;6274.874502509924;6276.121343011982;1001.7846163074973;1021.1422405179685;1021.5403068619152;1022.1158697726562;1026.4354604967239;5009.674371165863;5060.797568097309;5070;5075.111855425286;5076.263941728429;8010.239027292514;8071.112177660452;8180;8191.467554608931;8223;8118.797030074295;8138.83722325562;8146.2261085196815;8221.54781487012;8250.711225107092;6493.577917435446;6504.934950650433;6509.967450162719;6522.184726909137;6551.246606640298;6066.423689749467;6288.151099601495;6292.244930608356;6307.716152773228;6317.178766760292;7294.708211671686;7365.1530074042175;7428.73999410018;7430.219826918095;7463.962680186564;7443.181250062597;7514.023176986957;7581.886271705818;7618.428617853794;7662.157162711986;6122.938770612415;6150.753969841336;6176.722047507963;6178.814635560941;6188.504919606511;6565.704543295658;6607.041978912935;6621.735130594915;6649.2685804562425;6669;5385.138377859524;5534.501894829485;5679.602427830012;6133.53998450127;6342.524310676626;5983.371745966785;6022.608530445682;6038.215032045806;6106.206193195034;6150.169727086786;6149.2620885494025;6300.338464461349;6303.9684801575695;6309.4952403806665;6312.873742525216;5827;5879.647221166743;5883.676397798162;5885;5887.381824908323;5874.500667443144;5899.144624029406;5953.136795164591;5959.40405959418;5976.043832986701 22:55:19 INFO - 2015-12-11 22:55:19,350 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.8715765063373;294.2071118336085;295.11318487943737;300.5746868181523;306.5447810002147;5203.713795741232;5321.574274058075;5328.360596728388;5381.13901775715;5420.512153906147;5279.2872962150095;5285.180796976465;5294.020606187858;5302.575793936486;5304.045271851065;4125.546189919107;4133.979330103361;4136.958630413695;4147.605977432139;4153.1901279250405;4136.855210067648;4142.502899652046;4144.544100148981;4145.66834653227;4150.418941348214;4022.1151346703678;4103.610157035077;4114.621601763412;4115.444415003981;4119.196756632457;4059.188162367538;4088.2641124597562;4090.1206240658103;4093.89765255868;4096.713230073896;3571.4285714285847;3572.7141828653907;3575.1419659281587;3575.249197668493;3575.284943011408;5095.286659867622;5113.335266415379;5114.462981386975;5115.897682046376;5128.820491282787;4674.322223277606;4697.3893393858925;4701.271302948048;4713.6229101672125;4715.292706094079;5424.403315635277;5575.498205161555;5576.6375185613215;5581.134924086773;5590.944090559083;3881.378979363288;3886.514185726784;3888.766673999569;3891.241207964448;3893.8637147699696;5537.944620553783;5744.138379243105;5745.368009518949;5877.353491115974;5881.558883083786;4099.159672267178;4122.525909520384;4127.463429754112;4128.649064829463;4131.628153466142;4159.334506478949;4176.164767046603;4177.081042170717;4178.206140833232;4184.727992680466;4346.565343465628;4475.70907890986;4600.010997635458;4768.690035147704;4778.546038126373;5629.746661400247;5642.576806739511;5645.040343141676;5649.802256920988;5654.660720356792;1453.840077591464;1476.4758510728752;1477.2392218007735;1478.150063713369;1478.3790807860723;1003.0771690045176;1004.0110491166196;1009.3489699144011;1020.0411613083678;1030.6598822388594;4936.8765780855765;4964.925526117111;4965.230389289666;4973.726445045485;4975.477574854661;5800.477956983892;5815.185873977646;5827.446392592697;5829;5837.970810145922;4898.583620392306;4958.479359667255;4962.5533701967;4963.354763880672;4967.552920237196;3062.892798752033;3100.0544833825447;3134.843257837099;3138.4037032963665;3144.827034513078;5472;5472.5348345391085;5474.0293494342;5480.314960629921;5480.342358916955;5949.286085669747;5961.850953726192;5963.194968679173;5969.164316995624;5974.462298393166;5461.453854614507;5465.699386533699;5482.862928426742;5484.478974497416;5486.396496385394;5707.086866101404;5887.234659494409;5893;5904.645721256738;5904.940950590439;5752.568557358131;5753.194552762533;5757.683327416865;5760.567957403296;5766.654000759968;5551.417101204477;5555.72221388937;5558.027345214652;5558.583106267127;5563.443655634404;3927.842886284631;3954.268460334732;3973.6026397360033;4015.357542793139;4024.3561030235023;5564.221009058816;5717.771289148387;5851.473367396955;5852.707364631837;5853.239078919713;5530.446955304437;5641.435856414326;5665.461781130786;5674.77300907959;5689.829305120853;5618.634788738719;5653.858653533694;5658.745356458887;5658.971705141448;5663.631863928831;5396.244525766318;5525.900157939957;5529.585281103853;5541.224228608079;5546.750396232099;5700.68646224445;5701.515371193495;5707.058335374617;5713.571482138939;5714.971305165111;5562.944370556243;5565.387807341108;5567.638103523258;5568.276124103841;5572.192032155233 22:55:19 INFO - 2015-12-11 22:55:19,353 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.4173881331465;700.093379074099;766.3792328214146;767.9692812287509;785.6935795039935;10979.231453798237;11267.21129520934;11272.267302625323;11285.605003824847;11297.096232301417;11679.416029198548;11805;13221.272829994346;13580.932095339534;13610.863891361083;633.0567454492818;639.1307821362966;816.9101398846122;830.2278880641002;830.8047608811925;802.3661307567015;813.0203105258179;820.9466384685006;822.9753107406788;823.8269963307713;840.6973489543759;845.6490556419079;847.2036285891243;851.9574021298941;853.0318088969034;652.2010537092071;659.8812213801514;836.7238811192292;842.8609279468881;853.6628031927354;632.8228096133045;633.4299130782287;634.0900807341479;634.7397566997555;634.8317695810614;11572.6528204154;11683.299002059819;11695.298282103016;11718.648440546796;11740.178187526877;10395.636152734694;10466.895331046668;10558.736031599195;10720.142388608892;11442.141839361999;8582.914170858274;8910.242629376511;9012.954935225347;9067.164549670779;9202.493862837542;3015.4270688569322;3034.757219422441;3072.2933725243097;3117.6570577236484;3148.8110713357273;37823.432648510294;37912.052198694975;38156.42765358522;38346.233075338336;38430.423543646866;7597.886031709529;7632.084149902047;7684.077910650758;7770.456068075294;7829.843403131906;15664.216789160497;15898.682026359407;15938;15940.202989850693;15980.92009539968;6213.254409470802;6365.554411191265;6375.075614036032;6516.989866570594;6542.084108224853;3570.9642903571153;3638.890833275006;3640.362936486157;3699.186179040607;3706.9073273167846;2615.5422801009745;2638.9868050659625;2640.115561286952;2641.9735802642113;2643.590243512259;478.2873518457473;497.7635623079081;498.93264409305004;504.99495005050215;518.8676887393766;554.3569459427046;573.2461812716265;574.867780410508;588.8262962426008;594.7234535940809;7737.226277372218;7756.146823849372;7861.606919654108;7875.645595948082;8044.195580442026;482.5150723522837;498.7755510020505;511.2510172597163;568.2555851834028;636.8216899268213;3557.6086630470627;3771.585125636178;3780.1494663700446;3826.789526576065;3860.729748917549;47860.28209576859;48420.757896211;48608.513914861105;48850.51149488531;49172;43368.783156084646;43477;43954.780226098665;43963.56036439595;44233.778831105636;39019.21961560753;39732.602673973466;39814.80555583337;40004.1999160021;40026.79986600048;7497.812554686177;7566.205548417557;7614.162442131472;7628.618569071413;7642.961785191039;28186.2953426166;28639.284017899718;28885;28902;29172.416551669274;35659;36611.084722881074;36856.07859803527;37425;37721.62278377181;9109;9126.269898407978;9241.537923103684;9261.490618016074;9294.209992150743;10030.097291243823;10119.241056920908;10207.132393746615;10281.897181028393;10298.845517317395;9246.583903724482;9418.905810942077;9472.526373681427;9521.476318802255;9955.601775929172;9442.15020648145;9746.707598772047;9817;9973.30186886911;10077.496125193564;9450.00624141805;9492.95253523728;9565.186959108554;9665.565049572646;9737.415755054719;8616.43993140469;8629.43908645936;8899.199072083544;8936.195742383217;8956.820863582561;8499.702510412106;8594.527300998505;8660.566971651519;8671;8746 22:55:19 INFO - 2015-12-11 22:55:19,353 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:55:19 INFO - 2015-12-11 22:55:19,353 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:55:19 INFO - 2015-12-11 22:55:19,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,890 22:55:19 INFO - 2015-12-11 22:55:19,354 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:55:19 INFO - 2015-12-11 22:55:19,354 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903319341__endTimestamp 22:55:19 INFO - 2015-12-11 22:55:19,354 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,354 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:55:19 INFO - 2015-12-11 22:55:19,355 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:55:19 INFO - 2015-12-11 22:55:19,355 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,355 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4678.80 Median:4805.09 stddev:489.97 (10.2%) stddev-sans-first:464.19 22:55:19 INFO - 2015-12-11 22:55:19,355 DEBUG : BROWSER_OUTPUT: Values: 2623.8 2713.3 2713.5 2715.0 2725.5 4444.8 4554.3 4729.1 4753.0 4775.2 4600.9 4665.3 4760.2 4770.0 4791.6 4338.9 4343.1 4355.8 4409.7 4410.0 4382.4 4518.4 4521.8 4536.2 4537.7 4218.3 4265.4 4323.1 4453.7 4472.9 4396.6 4420.9 4426.4 4441.8 4444.0 4383.5 4385.8 4386.7 4423.4 4425.9 4476.0 4590.5 4667.2 4670.6 4697.4 4924.1 4962.8 5040.4 5041.1 5052.5 5160.2 5165.7 5169.2 5184.5 5190.1 4765.0 4785.8 4789.7 4790.7 4837.5 4880.9 5040.0 5044.7 5170.7 5272.0 4995.9 5022.4 5026.5 5027.9 5033.9 5114.8 5115.3 5117.1 5121.5 5149.9 4786.8 4856.7 4875.4 4878.1 4976.0 5081.6 5108.6 5108.9 5112.6 5169.6 4251.5 4271.3 4272.7 4276.2 4278.2 3565.2 3645.0 3661.0 3667.3 3728.2 4353.7 4365.2 4367.3 4381.6 4412.6 5036.5 5046.1 5048.4 5051.3 5089.9 4182.2 4265.1 4281.6 4348.7 4456.4 4449.5 4458.3 4460.3 4461.6 4485.1 4782.1 4785.1 4787.3 4789.4 4830.5 4841.1 4977.7 4980.7 5107.3 5237.3 4858.9 4872.1 4875.6 4878.4 4913.7 5049.4 5051.3 5056.6 5057.5 5099.3 4840.4 4967.3 4969.5 4974.4 5071.6 4941.2 4965.0 4975.5 4977.6 5014.0 4943.5 4948.6 4949.4 4951.5 5001.4 4640.4 4760.2 4763.4 4805.1 4905.9 5001.0 5006.1 5010.3 5030.4 5041.0 4892.7 4892.8 4900.3 4900.7 4904.5 22:55:19 INFO - 2015-12-11 22:55:19,355 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,356 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38919.89 Median:18550.21 stddev:57262.71 (308.7%) stddev-sans-first:57350.88 22:55:19 INFO - 2015-12-11 22:55:19,356 DEBUG : BROWSER_OUTPUT: Values: 552.0 558.1 566.9 579.9 588.2 26210.3 26806.9 26807.3 26839.5 26847.7 27309.7 27762.3 35205.8 35859.8 35912.5 7923.6 8088.0 8105.2 8108.4 8113.2 7192.4 7880.7 7932.9 7975.8 7995.0 7160.9 10255.3 10532.8 10538.7 10559.8 10074.4 10094.8 10184.7 10195.9 10199.6 7219.5 7449.6 9944.8 10140.0 10180.8 36261.0 36710.6 36746.0 36761.0 36811.1 2906.3 2909.4 2945.7 2965.5 2977.7 28328.4 28571.0 28642.4 28708.4 28745.4 3456.4 3556.0 3567.5 3605.4 3621.7 212345.0 214985.0 215060.0 215926.0 216816.0 55571.0 56003.9 56016.2 56053.4 56235.4 60242.4 60432.0 60540.7 60557.7 60571.1 12507.8 12611.9 12633.6 12636.3 12648.8 9951.4 9984.4 9987.8 10005.7 10016.0 19303.9 19548.8 19608.0 19636.5 19654.7 7777.4 7814.8 8028.4 8106.7 8108.3 839.4 919.6 953.1 1022.1 1032.1 25939.9 26399.2 26418.3 26513.7 26592.5 794.2 880.2 913.6 969.9 1046.4 12087.9 12543.6 12563.3 12973.2 13171.5 249059.0 252056.0 252413.0 252723.0 253750.0 41688.8 42831.0 44449.6 44766.3 44795.6 1190.7 1195.5 1198.2 1205.1 1208.7 24422.4 24488.0 25107.4 25801.9 29108.4 40036.0 40337.8 40387.4 40453.2 40454.4 189297.0 190350.0 190707.0 190739.0 191007.0 29065.9 29715.9 29752.0 41561.6 42224.2 37351.0 37421.4 38276.6 38345.2 38660.0 32891.5 32965.7 33165.8 33563.0 33644.0 39678.8 40990.6 41232.6 41398.0 42268.6 36154.0 36242.3 36656.6 36752.0 37169.3 36045.3 36729.6 36798.4 37009.3 37076.0 27848.2 28899.7 28900.7 28937.4 29209.4 22:55:19 INFO - 2015-12-11 22:55:19,356 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,356 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25131.00 Median:3680.47 stddev:71704.70 (1948.3%) stddev-sans-first:71881.66 22:55:19 INFO - 2015-12-11 22:55:19,357 DEBUG : BROWSER_OUTPUT: Values: 326.4 327.8 330.2 331.7 332.4 12463.4 12735.4 14731.2 15185.2 15281.5 14903.2 15043.8 15051.8 15061.7 15250.2 4954.1 4997.7 5000.7 5011.3 5016.5 3737.2 3832.8 4999.3 5582.8 5769.5 5520.5 5692.1 5699.4 5728.8 5731.2 5671.4 5695.9 5700.5 5705.8 5708.3 4941.1 5018.1 5019.2 5021.9 5033.2 18998.7 19288.3 19418.0 19467.3 19493.5 1859.7 1926.6 2003.3 2040.1 2042.3 12442.2 12511.9 12702.4 12827.7 13072.5 1746.9 1754.2 1766.4 1790.0 1823.1 52328.0 57811.7 58058.0 58408.7 59279.0 9074.6 9089.1 9136.7 9178.7 9256.7 11203.9 11216.2 11219.0 11222.4 11232.2 6539.3 6568.1 6693.6 6716.4 6724.5 6563.5 6565.6 6575.3 6618.9 6625.2 3626.0 3678.9 3682.1 3699.9 3702.3 1605.5 1646.7 1651.5 1702.3 1714.8 814.6 920.8 922.0 944.0 983.0 12558.8 15656.2 15673.5 15969.4 16286.3 829.3 835.1 848.4 851.8 861.2 8671.0 8746.7 8912.7 8917.3 9029.8 431070.0 434096.0 439433.0 442024.0 444141.0 69237.0 72727.3 72861.6 73118.3 74046.6 1034.1 1040.1 1046.1 1047.8 1048.6 13649.6 14211.2 14290.8 14486.5 14752.7 30037.5 30923.5 33539.7 34593.7 35429.5 42913.3 43544.3 45388.8 47868.8 51117.2 8839.8 8999.1 9180.6 9236.3 9253.7 15522.7 15650.6 15687.5 16724.4 16735.2 13885.6 14261.6 14351.2 14415.3 14519.4 12792.0 13402.9 13457.3 13646.8 13998.0 10688.3 10753.4 11064.1 13768.9 14280.0 7964.6 8352.6 8470.3 8837.5 8858.6 9841.5 13321.8 13679.7 13703.9 13748.7 22:55:19 INFO - 2015-12-11 22:55:19,357 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,357 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4790.15 Median:6052.32 stddev:2469.72 (40.8%) stddev-sans-first:2463.41 22:55:19 INFO - 2015-12-11 22:55:19,357 DEBUG : BROWSER_OUTPUT: Values: 1388.1 1651.0 1676.9 1712.2 1719.0 5702.9 6425.0 6611.2 6624.5 6625.8 6730.9 6868.9 6885.6 6895.1 6896.3 1719.1 1742.1 1745.7 2009.7 2045.1 1722.5 1730.1 2008.3 2040.2 2051.5 2011.9 2015.2 2016.8 2017.5 2018.4 1970.3 2031.6 2032.8 2034.3 2035.1 2001.9 2011.9 2038.0 2066.5 2067.0 6825.5 6895.9 6896.3 6898.4 6902.8 4093.0 4115.2 4150.9 4153.3 4185.3 2532.1 2562.7 2591.6 2594.5 2604.3 797.3 818.9 819.1 822.0 835.6 9223.8 9229.2 9241.9 9242.4 9244.7 3761.2 3765.3 3804.5 3860.5 3861.3 8044.3 8047.4 8051.8 8057.2 8058.6 4068.3 4087.8 4088.5 4093.7 4096.8 3722.0 3725.1 3728.8 3729.3 3732.3 3328.6 3349.6 3356.2 3404.1 3409.0 920.2 946.9 1005.8 1068.4 1068.7 850.9 858.9 859.1 902.8 1030.3 6220.6 6263.7 6273.9 6274.9 6276.1 1001.8 1021.1 1021.5 1022.1 1026.4 5009.7 5060.8 5070.0 5075.1 5076.3 8010.2 8071.1 8180.0 8191.5 8223.0 8118.8 8138.8 8146.2 8221.5 8250.7 6493.6 6504.9 6510.0 6522.2 6551.2 6066.4 6288.2 6292.2 6307.7 6317.2 7294.7 7365.2 7428.7 7430.2 7464.0 7443.2 7514.0 7581.9 7618.4 7662.2 6122.9 6150.8 6176.7 6178.8 6188.5 6565.7 6607.0 6621.7 6649.3 6669.0 5385.1 5534.5 5679.6 6133.5 6342.5 5983.4 6022.6 6038.2 6106.2 6150.2 6149.3 6300.3 6304.0 6309.5 6312.9 5827.0 5879.6 5883.7 5885.0 5887.4 5874.5 5899.1 5953.1 5959.4 5976.0 22:55:19 INFO - 2015-12-11 22:55:19,358 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,358 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4659.82 Median:5241.50 stddev:1365.45 (26.1%) stddev-sans-first:1329.34 22:55:19 INFO - 2015-12-11 22:55:19,358 DEBUG : BROWSER_OUTPUT: Values: 291.9 294.2 295.1 300.6 306.5 5203.7 5321.6 5328.4 5381.1 5420.5 5279.3 5285.2 5294.0 5302.6 5304.0 4125.5 4134.0 4137.0 4147.6 4153.2 4136.9 4142.5 4144.5 4145.7 4150.4 4022.1 4103.6 4114.6 4115.4 4119.2 4059.2 4088.3 4090.1 4093.9 4096.7 3571.4 3572.7 3575.1 3575.2 3575.3 5095.3 5113.3 5114.5 5115.9 5128.8 4674.3 4697.4 4701.3 4713.6 4715.3 5424.4 5575.5 5576.6 5581.1 5590.9 3881.4 3886.5 3888.8 3891.2 3893.9 5537.9 5744.1 5745.4 5877.4 5881.6 4099.2 4122.5 4127.5 4128.6 4131.6 4159.3 4176.2 4177.1 4178.2 4184.7 4346.6 4475.7 4600.0 4768.7 4778.5 5629.7 5642.6 5645.0 5649.8 5654.7 1453.8 1476.5 1477.2 1478.2 1478.4 1003.1 1004.0 1009.3 1020.0 1030.7 4936.9 4964.9 4965.2 4973.7 4975.5 5800.5 5815.2 5827.4 5829.0 5838.0 4898.6 4958.5 4962.6 4963.4 4967.6 3062.9 3100.1 3134.8 3138.4 3144.8 5472.0 5472.5 5474.0 5480.3 5480.3 5949.3 5961.9 5963.2 5969.2 5974.5 5461.5 5465.7 5482.9 5484.5 5486.4 5707.1 5887.2 5893.0 5904.6 5904.9 5752.6 5753.2 5757.7 5760.6 5766.7 5551.4 5555.7 5558.0 5558.6 5563.4 3927.8 3954.3 3973.6 4015.4 4024.4 5564.2 5717.8 5851.5 5852.7 5853.2 5530.4 5641.4 5665.5 5674.8 5689.8 5618.6 5653.9 5658.7 5659.0 5663.6 5396.2 5525.9 5529.6 5541.2 5546.8 5700.7 5701.5 5707.1 5713.6 5715.0 5562.9 5565.4 5567.6 5568.3 5572.2 22:55:19 INFO - 2015-12-11 22:55:19,358 DEBUG : BROWSER_OUTPUT: 22:55:19 INFO - 2015-12-11 22:55:19,358 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11713.51 Median:570.75 stddev:13285.58 (2327.7%) stddev-sans-first:13297.01 22:55:19 INFO - 2015-12-11 22:55:19,359 DEBUG : BROWSER_OUTPUT: Values: 681.4 700.1 766.4 768.0 785.7 10979.2 11267.2 11272.3 11285.6 11297.1 11679.4 11805.0 13221.3 13580.9 13610.9 633.1 639.1 816.9 830.2 830.8 802.4 813.0 820.9 823.0 823.8 840.7 845.6 847.2 852.0 853.0 652.2 659.9 836.7 842.9 853.7 632.8 633.4 634.1 634.7 634.8 11572.7 11683.3 11695.3 11718.6 11740.2 10395.6 10466.9 10558.7 10720.1 11442.1 8582.9 8910.2 9013.0 9067.2 9202.5 3015.4 3034.8 3072.3 3117.7 3148.8 37823.4 37912.1 38156.4 38346.2 38430.4 7597.9 7632.1 7684.1 7770.5 7829.8 15664.2 15898.7 15938.0 15940.2 15980.9 6213.3 6365.6 6375.1 6517.0 6542.1 3571.0 3638.9 3640.4 3699.2 3706.9 2615.5 2639.0 2640.1 2642.0 2643.6 478.3 497.8 498.9 505.0 518.9 554.4 573.2 574.9 588.8 594.7 7737.2 7756.1 7861.6 7875.6 8044.2 482.5 498.8 511.3 568.3 636.8 3557.6 3771.6 3780.1 3826.8 3860.7 47860.3 48420.8 48608.5 48850.5 49172.0 43368.8 43477.0 43954.8 43963.6 44233.8 39019.2 39732.6 39814.8 40004.2 40026.8 7497.8 7566.2 7614.2 7628.6 7643.0 28186.3 28639.3 28885.0 28902.0 29172.4 35659.0 36611.1 36856.1 37425.0 37721.6 9109.0 9126.3 9241.5 9261.5 9294.2 10030.1 10119.2 10207.1 10281.9 10298.8 9246.6 9418.9 9472.5 9521.5 9955.6 9442.2 9746.7 9817.0 9973.3 10077.5 9450.0 9493.0 9565.2 9665.6 9737.4 8616.4 8629.4 8899.2 8936.2 8956.8 8499.7 8594.5 8660.6 8671.0 8746.0 22:55:19 INFO - 2015-12-11 22:55:19,360 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:55:19 INFO - 2015-12-11 22:55:19,360 DEBUG : BROWSER_OUTPUT: 22:55:20 INFO - 2015-12-11 22:55:20,072 INFO : Browser exited with error code: 0 22:55:20 INFO - 2015-12-11 22:55:20,096 INFO : Completed test dromaeo_css (00:18:36) 22:55:20 INFO - 2015-12-11 22:55:20,096 INFO : Starting test kraken 22:55:20 INFO - 2015-12-11 22:55:20,096 DEBUG : operating with platform_type : linux_ 22:55:20 INFO - 2015-12-11 22:55:20,096 INFO : Initialising browser for kraken test... 22:55:20 INFO - 2015-12-11 22:55:20,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSHUAp/profile http://localhost:39330/getInfo.html 22:55:24 INFO - 2015-12-11 22:55:24,347 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:55:24 INFO - 2015-12-11 22:55:24,348 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:55:24 INFO - 2015-12-11 22:55:24,348 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:55:24 INFO - 2015-12-11 22:55:24,348 DEBUG : BROWSER_OUTPUT: __metrics 22:55:24 INFO - 2015-12-11 22:55:24,444 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:24 INFO - 2015-12-11 22:55:24,500 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:55:24 ERROR - 2015-12-11 22:55:24,508 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 22:55:25 INFO - 2015-12-11 22:55:25,321 INFO : Browser initialized. 22:55:25 INFO - 2015-12-11 22:55:25,322 INFO : Running cycle 1/1 for kraken test... 22:55:25 INFO - 2015-12-11 22:55:25,322 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSHUAp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:55:37 INFO - 2015-12-11 22:55:37,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 142372864 22:55:37 INFO - 2015-12-11 22:55:37,362 DEBUG : BROWSER_OUTPUT: 22:55:40 INFO - 2015-12-11 22:55:40,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39330/tests/kraken/driver.html?testName=audio-beat-detection) 22:55:40 INFO - 2015-12-11 22:55:40,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 181624832 22:55:40 INFO - 2015-12-11 22:55:40,596 DEBUG : BROWSER_OUTPUT: 22:55:43 INFO - 2015-12-11 22:55:43,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39330/tests/kraken/driver.html?testName=audio-dft) 22:55:43 INFO - 2015-12-11 22:55:43,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 167890944 22:55:43 INFO - 2015-12-11 22:55:43,892 DEBUG : BROWSER_OUTPUT: 22:55:46 INFO - 2015-12-11 22:55:46,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39330/tests/kraken/driver.html?testName=audio-fft) 22:55:47 INFO - 2015-12-11 22:55:47,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 152526848 22:55:47 INFO - 2015-12-11 22:55:47,451 DEBUG : BROWSER_OUTPUT: 22:55:49 INFO - 2015-12-11 22:55:49,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39330/tests/kraken/driver.html?testName=audio-oscillator) 22:55:50 INFO - 2015-12-11 22:55:50,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 156549120 22:55:50 INFO - 2015-12-11 22:55:50,081 DEBUG : BROWSER_OUTPUT: 22:55:52 INFO - 2015-12-11 22:55:52,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:55:52 INFO - 2015-12-11 22:55:52,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 158380032 22:55:52 INFO - 2015-12-11 22:55:52,908 DEBUG : BROWSER_OUTPUT: 22:55:55 INFO - 2015-12-11 22:55:55,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39330/tests/kraken/driver.html?testName=imaging-darkroom) 22:55:56 INFO - 2015-12-11 22:55:56,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 156196864 22:55:56 INFO - 2015-12-11 22:55:56,458 DEBUG : BROWSER_OUTPUT: 22:55:59 INFO - 2015-12-11 22:55:59,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39330/tests/kraken/driver.html?testName=imaging-desaturate) 22:56:00 INFO - 2015-12-11 22:56:00,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 158568448 22:56:00 INFO - 2015-12-11 22:56:00,433 DEBUG : BROWSER_OUTPUT: 22:56:03 INFO - 2015-12-11 22:56:03,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39330/tests/kraken/driver.html?testName=json-parse-financial) 22:56:03 INFO - 2015-12-11 22:56:03,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 158855168 22:56:03 INFO - 2015-12-11 22:56:03,853 DEBUG : BROWSER_OUTPUT: 22:56:05 INFO - 2015-12-11 22:56:05,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:56:06 INFO - 2015-12-11 22:56:06,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 167628800 22:56:06 INFO - 2015-12-11 22:56:06,187 DEBUG : BROWSER_OUTPUT: 22:56:08 INFO - 2015-12-11 22:56:08,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:56:08 INFO - 2015-12-11 22:56:08,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 167284736 22:56:08 INFO - 2015-12-11 22:56:08,648 DEBUG : BROWSER_OUTPUT: 22:56:10 INFO - 2015-12-11 22:56:10,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:56:11 INFO - 2015-12-11 22:56:11,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 180203520 22:56:11 INFO - 2015-12-11 22:56:11,374 DEBUG : BROWSER_OUTPUT: 22:56:13 INFO - 2015-12-11 22:56:13,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:56:14 INFO - 2015-12-11 22:56:14,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 184643584 22:56:14 INFO - 2015-12-11 22:56:14,520 DEBUG : BROWSER_OUTPUT: 22:56:17 INFO - 2015-12-11 22:56:17,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:56:17 INFO - 2015-12-11 22:56:17,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 183029760 22:56:17 INFO - 2015-12-11 22:56:17,815 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39330/tests/kraken/driver.html?testName=ai-astar) 22:56:19 INFO - 2015-12-11 22:56:19,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 240910336 22:56:19 INFO - 2015-12-11 22:56:19,859 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;106;113;113;111;101;113;113;112 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;136;149;164;131;161;164;132;166;128 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;163;161;163;161;163;161 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;95;72;74;72;106;89;72 22:56:19 INFO - 2015-12-11 22:56:19,860 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;129;93;95;94;129;94;94;132 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;146;147;147;147;146 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;95;97;97;96;96 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;72;74;73;72;74;71;80;72;71 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;69;68;68;68 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;86;84;84;86;88;86;87;86 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;122;125;134;130;129;124;121;131;126 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;145;154;157;154;142;168;155;152;143 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;74;73;74;73;70;71;73;71 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:56:19 INFO - 2015-12-11 22:56:19,861 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903379858__endTimestamp 22:56:19 INFO - 2015-12-11 22:56:19,862 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:3.98 (3.5%) stddev-sans-first:4.19 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 106.0 113.0 113.0 111.0 101.0 113.0 113.0 112.0 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:157.00 stddev:15.34 (9.8%) stddev-sans-first:16.18 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: Values: 153.0 136.0 149.0 164.0 131.0 161.0 164.0 132.0 166.0 128.0 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 22:56:19 INFO - 2015-12-11 22:56:19,865 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 163.0 161.0 163.0 161.0 163.0 161.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:73.50 stddev:12.16 (16.5%) stddev-sans-first:12.46 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 95.0 72.0 74.0 72.0 106.0 89.0 72.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:17.42 (18.5%) stddev-sans-first:18.03 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 129.0 93.0 95.0 94.0 129.0 94.0 94.0 132.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 95.0 97.0 97.0 96.0 96.0 22:56:19 INFO - 2015-12-11 22:56:19,866 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.50 stddev:2.67 (3.6%) stddev-sans-first:2.77 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 74.0 73.0 72.0 74.0 71.0 80.0 72.0 71.0 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 68.0 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.43 (1.7%) stddev-sans-first:1.41 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 86.0 84.0 84.0 86.0 88.0 86.0 87.0 86.0 22:56:19 INFO - 2015-12-11 22:56:19,867 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:127.50 stddev:4.22 (3.3%) stddev-sans-first:4.37 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: Values: 124.0 122.0 125.0 134.0 130.0 129.0 124.0 121.0 131.0 126.0 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:154.00 stddev:7.69 (5.0%) stddev-sans-first:8.12 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: Values: 150.0 145.0 154.0 157.0 154.0 142.0 168.0 155.0 152.0 143.0 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 74.0 73.0 74.0 73.0 70.0 71.0 73.0 71.0 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:19 INFO - 2015-12-11 22:56:19,868 DEBUG : BROWSER_OUTPUT: 22:56:20 INFO - 2015-12-11 22:56:20,692 INFO : Browser exited with error code: 0 22:56:20 INFO - 2015-12-11 22:56:20,750 INFO : Completed test kraken (00:01:00) 22:56:20 INFO - 2015-12-11 22:56:20,750 INFO : Starting test v8_7 22:56:20 INFO - 2015-12-11 22:56:20,750 DEBUG : operating with platform_type : linux_ 22:56:20 INFO - 2015-12-11 22:56:20,750 INFO : Initialising browser for v8_7 test... 22:56:20 INFO - 2015-12-11 22:56:20,756 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6DQJd/profile http://localhost:39330/getInfo.html 22:56:24 INFO - 2015-12-11 22:56:24,600 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:56:24 INFO - 2015-12-11 22:56:24,600 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:56:24 INFO - 2015-12-11 22:56:24,600 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:56:24 INFO - 2015-12-11 22:56:24,600 DEBUG : BROWSER_OUTPUT: __metrics 22:56:24 INFO - 2015-12-11 22:56:24,697 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:24 INFO - 2015-12-11 22:56:24,778 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:56:25 INFO - 2015-12-11 22:56:25,875 INFO : Browser initialized. 22:56:25 INFO - 2015-12-11 22:56:25,875 INFO : Running cycle 1/1 for v8_7 test... 22:56:25 INFO - 2015-12-11 22:56:25,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6DQJd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:56:37 INFO - 2015-12-11 22:56:37,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 22:56:37 INFO - 2015-12-11 22:56:37,898 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39330/tests/v8_7/run.html (next: http://localhost:39330/tests/v8_7/run.html) 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 443928576 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:59 INFO - 2015-12-11 22:56:59,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.35855385762207 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 22:56:59 INFO - 2015-12-11 22:56:59,566 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: |6;Boyer;12023.809523809523 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: |7;RegExp;28800 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: |8;Splay;604.5949214026602 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1449903419562__endTimestamp 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,567 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: Values: 165.7 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.36 Median:186.36 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: Values: 186.4 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: Values: 278.4 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,568 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: Values: 5181.3 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: Values: 1976.3 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: Values: 788.6 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: Values: 12023.8 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,569 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28800.00 Median:28800.00 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: Values: 28800.0 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: Values: 604.6 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: Values: 4835.7 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:59 INFO - 2015-12-11 22:56:59,570 DEBUG : BROWSER_OUTPUT: 22:57:00 INFO - 2015-12-11 22:57:00,508 INFO : Browser exited with error code: 0 22:57:00 INFO - 2015-12-11 22:57:00,523 INFO : Completed test v8_7 (00:00:39) 22:57:00 INFO - 2015-12-11 22:57:00,575 INFO : Completed test suite (00:20:17) 22:57:00 INFO - 2015-12-11 22:57:00,575 DEBUG : Working with test: dromaeo_css 22:57:00 INFO - 2015-12-11 22:57:00,576 DEBUG : Generating results file: dromaeo_css 22:57:00 INFO - 2015-12-11 22:57:00,577 DEBUG : Working with test: kraken 22:57:00 INFO - 2015-12-11 22:57:00,577 DEBUG : Generating results file: kraken 22:57:00 INFO - 2015-12-11 22:57:00,577 INFO : javascript benchmark 22:57:00 INFO - 2015-12-11 22:57:00,577 DEBUG : Working with test: v8_7 22:57:00 INFO - 2015-12-11 22:57:00,577 DEBUG : Generating results file: v8_7 22:57:00 INFO - 2015-12-11 22:57:00,578 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:57:00 INFO - 2015-12-11 22:57:00,623 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:57:00 INFO - 2015-12-11 22:57:00,623 DEBUG : process_Request line: dromaeo_css 6259.77 graph.html#tests=[[72,132,35]] 22:57:00 INFO - 2015-12-11 22:57:00,623 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:57:00 INFO - 2015-12-11 22:57:00,651 DEBUG : process_Request line: kraken 1536.00 graph.html#tests=[[232,132,35]] 22:57:00 INFO - 2015-12-11 22:57:00,651 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:57:00 INFO - 2015-12-11 22:57:00,675 DEBUG : process_Request line: v8_7 19715.37 graph.html#tests=[[230,132,35]] 22:57:00 INFO - 2015-12-11 22:57:00,677 INFO : javascript benchmark 22:57:00 INFO - 2015-12-11 22:57:00,680 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.8425694458333, 2713.3081064328594, 2713.4573085382926, 2715.0497325935926, 2725.4957832800933, 4444.79998400072, 4554.339620754989, 4729.077829823182, 4753.0, 4775.235962246037, 4600.907981840362, 4665.276882083274, 4760.190767569513, 4770.0, 4791.592714619253, 4338.891527711801, 4343.109662519184, 4355.847545335914, 4409.713368631044, 4409.977950110245, 4382.364557139213, 4518.412606361168, 4521.796519156629, 4536.160810250098, 4537.659675524349, 4218.261804184255, 4265.360195970598, 4323.135372925396, 4453.6659750518675, 4472.865814025552, 4396.582324679151, 4420.889477763049, 4426.380306757057, 4441.777911104464, 4443.977780111111, 4383.517813040563, 4385.8245670173155, 4386.736795792231, 4423.424954755861, 4425.889352766175, 4476.0, 4590.540945905416, 4667.22990706533, 4670.556297151799, 4697.412823397075, 4924.113659541281, 4962.776675049631, 5040.395152581714, 5041.143005689041, 5052.494750524918, 5160.174372100446, 5165.66423182492, 5169.224616307546, 5184.507471790174, 5190.143626301656, 4764.976175119103, 4785.784639691222, 4789.712617242907, 4790.664653474293, 4837.467878533358, 4880.853574392703, 5039.974800125976, 5044.672096313801, 5170.689758614495, 5272.0, 4995.850124496271, 5022.42242142151, 5026.54761071498, 5027.949720502748, 5033.899322013539, 5114.820981265712, 5115.335006449212, 5117.078925793393, 5121.4622464641425, 5149.948500515022, 4786.7845946932475, 4856.68431551955, 4875.390576177978, 4878.121938051185, 4975.975120124449, 5081.618878584121, 5108.565771909355, 5108.923366149511, 5112.616553758408, 5169.586433085344, 4251.489821221473, 4271.31658934569, 4272.658187345067, 4276.2302785498905, 4278.2085314216965, 3565.16218688608, 3645.0, 3661.0, 3667.339878821838, 3728.179800443898, 4353.717008394444, 4365.236083685342, 4367.344898265222, 4381.627561657231, 4412.580804823537, 5036.496350365008, 5046.1169295373165, 5048.444671086178, 5051.292819005343, 5089.949100509021, 4182.226288136704, 4265.0616864289805, 4281.571842815693, 4348.673849461303, 4456.442944631921, 4449.488308844524, 4458.308962110878, 4460.264056430653, 4461.598456138963, 4485.147821913891, 4782.115308667908, 4785.090832741768, 4787.305840653155, 4789.353437285922, 4830.516948305141, 4841.1285968526, 4977.701337919736, 4980.676256043345, 5107.336046313955, 5237.319148510669, 4858.854234372974, 4872.074305881871, 4875.6099512038245, 4878.414590249193, 4913.680610760289, 5049.394072711151, 5051.343325367826, 5056.595472362275, 5057.519535644108, 5099.26060721186, 4840.443349014768, 4967.279744437109, 4969.527894849984, 4974.403071631427, 5071.619628527801, 4941.184704523714, 4964.975175124101, 4975.502449754996, 4977.626677999092, 5014.0, 4943.530364615356, 4948.604111671129, 4949.430815456269, 4951.455339912534, 5001.449840517613, 4640.350350950802, 4760.190767569452, 4763.380760501252, 4805.087033463631, 4905.852824415273, 5000.974995125001, 5006.098902197494, 5010.348654674869, 5030.4466508684745, 5041.0, 4892.68197567157, 4892.828750993698, 4900.313956046085, 4900.730459824744, 4904.4605093440405], "unit": "ms", "name": "dojo.html", "value": 4648.050420826382}, {"lowerIsBetter": false, "replicates": [551.9937078437449, 558.1042426904818, 566.8894565559713, 579.8985177593921, 588.182426427266, 26210.344741381476, 26806.927722891087, 26807.329816754544, 26839.463210735797, 26847.731522684768, 27309.726902730967, 27762.30594235145, 35205.82397088017, 35859.820700896526, 35912.46131308033, 7923.6038198090155, 8088.0, 8105.230003149692, 8108.391870609698, 8113.229243221914, 7192.388646965014, 7880.724174653888, 7932.8810067848735, 7975.7607271781935, 7995.0, 7160.85678286434, 10255.333403328797, 10532.842007369896, 10538.68383948479, 10559.841602375971, 10074.445905475195, 10094.79810403795, 10184.74538136545, 10195.949020254926, 10199.592016319339, 7219.530730502501, 7449.590272535009, 9944.801103977952, 10140.0, 10180.847287290697, 36261.0, 36710.63289367099, 36746.0, 36761.0, 36811.07972300687, 2906.287959449948, 2909.418116376712, 2945.7054294570585, 2965.54034124711, 2977.702229777027, 28328.433431331257, 28571.0, 28642.42715145706, 28708.425831483462, 28745.425091498262, 3456.4296891012955, 3555.982220088909, 3567.4827150063097, 3605.405108157151, 3621.7102631789658, 212345.0, 214985.0, 215060.0, 215926.0, 216816.0, 55571.0, 56003.87943748134, 56016.159757603666, 56053.439465604824, 56235.43764562384, 60242.39757602455, 60432.0, 60540.69729651412, 60557.69721151366, 60571.09143362853, 12507.812382814265, 12611.873881261254, 12633.620991370273, 12636.30500322491, 12648.810267845989, 9951.353162044588, 9984.400935943866, 9987.800243995225, 10005.699829005142, 10016.0, 19303.903480482506, 19548.804511954982, 19608.0, 19636.509087272934, 19654.70517942232, 7777.377809775205, 7814.765557033184, 8028.357731381476, 8106.675732970615, 8108.270255677017, 839.4040231435627, 919.6275508418967, 953.0755167487526, 1022.0750221049962, 1032.0969151992008, 25939.92837690938, 26399.208023759318, 26418.339541511617, 26513.734862651127, 26592.468150637265, 794.2018271636967, 880.1638443478721, 913.6482454255159, 969.9321047526746, 1046.4401545173296, 12087.87912120885, 12543.623691289276, 12563.309018003914, 12973.156744811557, 13171.538996135281, 249059.0, 252056.0, 252413.0, 252723.0, 253750.0, 41688.79155604202, 42831.0, 44449.55550444454, 44766.32850507245, 44795.55204447914, 1190.6725650446197, 1195.5277665322149, 1198.2391181599746, 1205.0961778665826, 1208.6796998795326, 24422.389440264134, 24487.97996410696, 25107.372315692253, 25801.870990644926, 29108.417831642826, 40036.0, 40337.79831100826, 40387.3941890866, 40453.1909361817, 40454.393184101675, 189297.0, 190350.0, 190707.0, 190739.0, 191007.0, 29065.854670727356, 29715.851420742758, 29752.0, 41561.58438415577, 42224.19982201617, 37351.0, 37421.4386784193, 38276.6172338273, 38345.233095338495, 38660.0, 32891.50662740013, 32965.67034329626, 33165.834170829956, 33563.0, 33644.0, 39678.801605991786, 40990.59009409987, 41232.58767412287, 41398.0, 42268.577314226466, 36154.0, 36242.27515449729, 36656.633433666386, 36752.0, 37169.25661486809, 36045.27909441849, 36729.63270367262, 36798.44802328021, 37009.259814803016, 37076.0, 27848.16455506338, 28899.7110028897, 28900.710992889803, 28937.421251575273, 29209.415811684074], "unit": "ms", "name": "ext.html", "value": 17075.280179054625}, {"lowerIsBetter": false, "replicates": [326.4222326482128, 327.8360819590205, 330.1893850596785, 331.73295497124815, 332.42988275108183, 12463.376831158452, 12735.426905789238, 14731.189784561844, 15185.240737963099, 15281.541553753392, 14903.180325082116, 15043.849561504381, 15051.774223386657, 15061.698766024672, 15250.237488125576, 4954.08349455351, 4997.675151115184, 5000.699958002531, 5011.32347133136, 5016.548510634042, 3737.1591391936868, 3832.7891965941863, 4999.275105109757, 5582.771790206169, 5769.509591684712, 5520.530754885839, 5692.0608099663505, 5699.430056994288, 5728.828135155931, 5731.226284451608, 5671.376148623648, 5695.914561281584, 5700.543956483471, 5705.828825135231, 5708.286464191976, 4941.061198372297, 5018.146915024455, 5019.171836646949, 5021.895183059721, 5033.1695270280725, 18998.71501927472, 19288.324908628132, 19418.029098545016, 19467.31864384754, 19493.512662183417, 1859.7024476083898, 1926.566522532433, 2003.3188715836686, 2040.0513761101158, 2042.3362407217564, 12442.17578561182, 12511.874881251162, 12702.42839072244, 12827.743445131046, 13072.542461013818, 1746.8777185597014, 1754.1843042984945, 1766.3994241957796, 1789.9910500447545, 1823.088455772114, 52328.0, 57811.710941445446, 58058.0, 58408.70795646037, 59279.0, 9074.637014519478, 9089.091090890857, 9136.6802161924, 9178.724638260863, 9256.72229833106, 11203.887961120448, 11216.158788090926, 11219.0, 11222.382768947786, 11232.157588180919, 6539.346065393423, 6568.146141001735, 6693.631850248185, 6716.395524402729, 6724.529282950147, 6563.50773691975, 6565.606063636197, 6575.309592492815, 6618.86762264752, 6625.204975402886, 3625.9818700906326, 3678.8528458861883, 3682.0794801299676, 3699.852005919733, 3702.259548090393, 1605.4621701729818, 1646.6706658668313, 1651.5458248981627, 1702.3360889253202, 1714.802797678258, 814.608987685914, 920.802027564077, 921.9815603687889, 943.9528023598792, 982.9655962041294, 12558.81161782574, 15656.217189140498, 15673.529794106194, 15969.44106956251, 16286.348546058025, 829.2785276809215, 835.07723965019, 848.3510114762212, 851.7870532366908, 861.2033868671579, 8671.0, 8746.69386571467, 8912.73261802134, 8917.331200159884, 9029.77425564366, 431070.0, 434096.0, 439433.0, 442024.0, 444141.0, 69237.0, 72727.27272727311, 72861.6356918212, 73118.26881731222, 74046.62976685082, 1034.0590063042596, 1040.0795296162798, 1046.1212581431635, 1047.7799662070897, 1048.570086264628, 13649.590512284647, 14211.218382988622, 14290.78528325104, 14486.492972745904, 14752.704945900807, 30037.54943675803, 30923.493332671333, 33539.66460335365, 34593.65406345904, 35429.46855797217, 42913.267754318316, 43544.34683479687, 45388.77305613451, 47868.76065619649, 51117.23324150066, 8839.823203536022, 8999.100089990949, 9180.632774688938, 9236.30727695439, 9253.67612133572, 15522.689546208787, 15650.608734781721, 15687.529374118794, 16724.414645487348, 16735.24691388866, 13885.583432497042, 14261.643458913195, 14351.210683412513, 14415.279236038366, 14519.419223230952, 12791.95328747396, 13402.93298533501, 13457.259850707913, 13646.795298070736, 13998.0, 10688.25182237236, 10753.354798712102, 11064.114870810477, 13768.931155344158, 14280.0, 7964.6415911282975, 8352.6241319142, 8470.32237421017, 8837.469751814911, 8858.64565417376, 9841.507924603884, 13321.800172997218, 13679.726405472034, 13703.862961370658, 13748.65628359299], "unit": "ms", "name": "jquery.html", "value": 8260.85769448474}, {"lowerIsBetter": false, "replicates": [1388.0838646493316, 1650.9752353714694, 1676.9077700726464, 1712.2380540659403, 1718.9914050429745, 5702.942970570293, 6425.0, 6611.206655201383, 6624.536282460223, 6625.768098116567, 6730.932690673092, 6868.896966545493, 6885.552439091455, 6895.103636527245, 6896.310368963102, 1719.1318384215954, 1742.120229284216, 1745.7381392791056, 2009.6884982827648, 2045.0694933805157, 1722.4832550234942, 1730.0657644871817, 2008.3071340387544, 2040.1737296394983, 2051.52814852584, 2011.8893460859647, 2015.2039944222024, 2016.84873634478, 2017.4855411870026, 2018.374303965768, 1970.3005433071269, 2031.5632139090167, 2032.7662318833375, 2034.2778313698645, 2035.1248962945926, 2001.8698784578955, 2011.9195232190696, 2037.9796202037937, 2066.4730493724155, 2066.95866082679, 6825.48808839339, 6895.931040689579, 6896.310368963063, 6898.379145876845, 6902.758403455855, 4092.9590704092875, 4115.156392939441, 4150.896227594304, 4153.314703073989, 4185.2885009548145, 2532.113760183939, 2562.6796650418696, 2591.5853463445947, 2594.545954457981, 2604.322876052221, 797.3063434811693, 818.9262966332999, 819.0539926385035, 821.9712310069178, 835.5696816139692, 9223.815523689556, 9229.21551668109, 9241.861372079424, 9242.399244049115, 9244.676436324697, 3761.153740408386, 3765.3410653135593, 3804.4863943367845, 3860.536735591691, 3861.2856621525107, 8044.31623312025, 8047.356211503065, 8051.758447246592, 8057.153998830038, 8058.556779377073, 4068.2880495913096, 4087.7547347159266, 4088.509378874495, 4093.692973027035, 4096.795160241976, 3721.981390093032, 3725.0501122214205, 3728.757630753992, 3729.254149170177, 3732.309522738302, 3328.6338502764675, 3349.581302337208, 3356.16095976006, 3404.1149301181376, 3409.0113866978795, 920.2362039507193, 946.9479178645103, 1005.8038682456851, 1068.4444089073638, 1068.7488440216543, 850.9234168924827, 858.914108589136, 859.0764927702744, 902.7517432706059, 1030.3199888073834, 6220.595661282002, 6263.749450022039, 6273.905891411632, 6274.874502509924, 6276.121343011982, 1001.7846163074973, 1021.1422405179685, 1021.5403068619152, 1022.1158697726562, 1026.4354604967239, 5009.674371165863, 5060.797568097309, 5070.0, 5075.111855425286, 5076.263941728429, 8010.239027292514, 8071.112177660452, 8180.0, 8191.467554608931, 8223.0, 8118.797030074295, 8138.83722325562, 8146.2261085196815, 8221.54781487012, 8250.711225107092, 6493.577917435446, 6504.934950650433, 6509.967450162719, 6522.184726909137, 6551.246606640298, 6066.423689749467, 6288.151099601495, 6292.244930608356, 6307.716152773228, 6317.178766760292, 7294.708211671686, 7365.1530074042175, 7428.73999410018, 7430.219826918095, 7463.962680186564, 7443.181250062597, 7514.023176986957, 7581.886271705818, 7618.428617853794, 7662.157162711986, 6122.938770612415, 6150.753969841336, 6176.722047507963, 6178.814635560941, 6188.504919606511, 6565.704543295658, 6607.041978912935, 6621.735130594915, 6649.2685804562425, 6669.0, 5385.138377859524, 5534.501894829485, 5679.602427830012, 6133.53998450127, 6342.524310676626, 5983.371745966785, 6022.608530445682, 6038.215032045806, 6106.206193195034, 6150.169727086786, 6149.2620885494025, 6300.338464461349, 6303.9684801575695, 6309.4952403806665, 6312.873742525216, 5827.0, 5879.647221166743, 5883.676397798162, 5885.0, 5887.381824908323, 5874.500667443144, 5899.144624029406, 5953.136795164591, 5959.40405959418, 5976.043832986701], "unit": "ms", "name": "mootools.html", "value": 3932.347521766263}, {"lowerIsBetter": false, "replicates": [291.8715765063373, 294.2071118336085, 295.11318487943737, 300.5746868181523, 306.5447810002147, 5203.713795741232, 5321.574274058075, 5328.360596728388, 5381.13901775715, 5420.512153906147, 5279.2872962150095, 5285.180796976465, 5294.020606187858, 5302.575793936486, 5304.045271851065, 4125.546189919107, 4133.979330103361, 4136.958630413695, 4147.605977432139, 4153.1901279250405, 4136.855210067648, 4142.502899652046, 4144.544100148981, 4145.66834653227, 4150.418941348214, 4022.1151346703678, 4103.610157035077, 4114.621601763412, 4115.444415003981, 4119.196756632457, 4059.188162367538, 4088.2641124597562, 4090.1206240658103, 4093.89765255868, 4096.713230073896, 3571.4285714285847, 3572.7141828653907, 3575.1419659281587, 3575.249197668493, 3575.284943011408, 5095.286659867622, 5113.335266415379, 5114.462981386975, 5115.897682046376, 5128.820491282787, 4674.322223277606, 4697.3893393858925, 4701.271302948048, 4713.6229101672125, 4715.292706094079, 5424.403315635277, 5575.498205161555, 5576.6375185613215, 5581.134924086773, 5590.944090559083, 3881.378979363288, 3886.514185726784, 3888.766673999569, 3891.241207964448, 3893.8637147699696, 5537.944620553783, 5744.138379243105, 5745.368009518949, 5877.353491115974, 5881.558883083786, 4099.159672267178, 4122.525909520384, 4127.463429754112, 4128.649064829463, 4131.628153466142, 4159.334506478949, 4176.164767046603, 4177.081042170717, 4178.206140833232, 4184.727992680466, 4346.565343465628, 4475.70907890986, 4600.010997635458, 4768.690035147704, 4778.546038126373, 5629.746661400247, 5642.576806739511, 5645.040343141676, 5649.802256920988, 5654.660720356792, 1453.840077591464, 1476.4758510728752, 1477.2392218007735, 1478.150063713369, 1478.3790807860723, 1003.0771690045176, 1004.0110491166196, 1009.3489699144011, 1020.0411613083678, 1030.6598822388594, 4936.8765780855765, 4964.925526117111, 4965.230389289666, 4973.726445045485, 4975.477574854661, 5800.477956983892, 5815.185873977646, 5827.446392592697, 5829.0, 5837.970810145922, 4898.583620392306, 4958.479359667255, 4962.5533701967, 4963.354763880672, 4967.552920237196, 3062.892798752033, 3100.0544833825447, 3134.843257837099, 3138.4037032963665, 3144.827034513078, 5472.0, 5472.5348345391085, 5474.0293494342, 5480.314960629921, 5480.342358916955, 5949.286085669747, 5961.850953726192, 5963.194968679173, 5969.164316995624, 5974.462298393166, 5461.453854614507, 5465.699386533699, 5482.862928426742, 5484.478974497416, 5486.396496385394, 5707.086866101404, 5887.234659494409, 5893.0, 5904.645721256738, 5904.940950590439, 5752.568557358131, 5753.194552762533, 5757.683327416865, 5760.567957403296, 5766.654000759968, 5551.417101204477, 5555.72221388937, 5558.027345214652, 5558.583106267127, 5563.443655634404, 3927.842886284631, 3954.268460334732, 3973.6026397360033, 4015.357542793139, 4024.3561030235023, 5564.221009058816, 5717.771289148387, 5851.473367396955, 5852.707364631837, 5853.239078919713, 5530.446955304437, 5641.435856414326, 5665.461781130786, 5674.77300907959, 5689.829305120853, 5618.634788738719, 5653.858653533694, 5658.745356458887, 5658.971705141448, 5663.631863928831, 5396.244525766318, 5525.900157939957, 5529.585281103853, 5541.224228608079, 5546.750396232099, 5700.68646224445, 5701.515371193495, 5707.058335374617, 5713.571482138939, 5714.971305165111, 5562.944370556243, 5565.387807341108, 5567.638103523258, 5568.276124103841, 5572.192032155233], "unit": "ms", "name": "prototype.html", "value": 4221.587852422783}, {"lowerIsBetter": false, "replicates": [681.4173881331465, 700.093379074099, 766.3792328214146, 767.9692812287509, 785.6935795039935, 10979.231453798237, 11267.21129520934, 11272.267302625323, 11285.605003824847, 11297.096232301417, 11679.416029198548, 11805.0, 13221.272829994346, 13580.932095339534, 13610.863891361083, 633.0567454492818, 639.1307821362966, 816.9101398846122, 830.2278880641002, 830.8047608811925, 802.3661307567015, 813.0203105258179, 820.9466384685006, 822.9753107406788, 823.8269963307713, 840.6973489543759, 845.6490556419079, 847.2036285891243, 851.9574021298941, 853.0318088969034, 652.2010537092071, 659.8812213801514, 836.7238811192292, 842.8609279468881, 853.6628031927354, 632.8228096133045, 633.4299130782287, 634.0900807341479, 634.7397566997555, 634.8317695810614, 11572.6528204154, 11683.299002059819, 11695.298282103016, 11718.648440546796, 11740.178187526877, 10395.636152734694, 10466.895331046668, 10558.736031599195, 10720.142388608892, 11442.141839361999, 8582.914170858274, 8910.242629376511, 9012.954935225347, 9067.164549670779, 9202.493862837542, 3015.4270688569322, 3034.757219422441, 3072.2933725243097, 3117.6570577236484, 3148.8110713357273, 37823.432648510294, 37912.052198694975, 38156.42765358522, 38346.233075338336, 38430.423543646866, 7597.886031709529, 7632.084149902047, 7684.077910650758, 7770.456068075294, 7829.843403131906, 15664.216789160497, 15898.682026359407, 15938.0, 15940.202989850693, 15980.92009539968, 6213.254409470802, 6365.554411191265, 6375.075614036032, 6516.989866570594, 6542.084108224853, 3570.9642903571153, 3638.890833275006, 3640.362936486157, 3699.186179040607, 3706.9073273167846, 2615.5422801009745, 2638.9868050659625, 2640.115561286952, 2641.9735802642113, 2643.590243512259, 478.2873518457473, 497.7635623079081, 498.93264409305004, 504.99495005050215, 518.8676887393766, 554.3569459427046, 573.2461812716265, 574.867780410508, 588.8262962426008, 594.7234535940809, 7737.226277372218, 7756.146823849372, 7861.606919654108, 7875.645595948082, 8044.195580442026, 482.5150723522837, 498.7755510020505, 511.2510172597163, 568.2555851834028, 636.8216899268213, 3557.6086630470627, 3771.585125636178, 3780.1494663700446, 3826.789526576065, 3860.729748917549, 47860.28209576859, 48420.757896211, 48608.513914861105, 48850.51149488531, 49172.0, 43368.783156084646, 43477.0, 43954.780226098665, 43963.56036439595, 44233.778831105636, 39019.21961560753, 39732.602673973466, 39814.80555583337, 40004.1999160021, 40026.79986600048, 7497.812554686177, 7566.205548417557, 7614.162442131472, 7628.618569071413, 7642.961785191039, 28186.2953426166, 28639.284017899718, 28885.0, 28902.0, 29172.416551669274, 35659.0, 36611.084722881074, 36856.07859803527, 37425.0, 37721.62278377181, 9109.0, 9126.269898407978, 9241.537923103684, 9261.490618016074, 9294.209992150743, 10030.097291243823, 10119.241056920908, 10207.132393746615, 10281.897181028393, 10298.845517317395, 9246.583903724482, 9418.905810942077, 9472.526373681427, 9521.476318802255, 9955.601775929172, 9442.15020648145, 9746.707598772047, 9817.0, 9973.30186886911, 10077.496125193564, 9450.00624141805, 9492.95253523728, 9565.186959108554, 9665.565049572646, 9737.415755054719, 8616.43993140469, 8629.43908645936, 8899.199072083544, 8936.195742383217, 8956.820863582561, 8499.702510412106, 8594.527300998505, 8660.566971651519, 8671.0, 8746.0], "unit": "ms", "name": "yui.html", "value": 5527.259933456449}], "name": "dromaeo_css", "value": 6259.765697674369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 113.0, 113.0, 111.0, 101.0, 113.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [153.0, 136.0, 149.0, 164.0, 131.0, 161.0, 164.0, 132.0, 166.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 161.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 95.0, 72.0, 74.0, 72.0, 106.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 129.0, 93.0, 95.0, 94.0, 129.0, 94.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 74.0, 73.0, 72.0, 74.0, 71.0, 80.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 84.0, 84.0, 86.0, 88.0, 86.0, 87.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 125.0, 134.0, 130.0, 129.0, 124.0, 121.0, 131.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [150.0, 145.0, 154.0, 157.0, 154.0, 142.0, 168.0, 155.0, 152.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 73.0, 74.0, 73.0, 70.0, 71.0, 73.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1536.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [186.35855385762207], "unit": "score", "name": "DeltaBlue", "value": 354.7891880000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12023.809523809523], "unit": "score", "name": "Boyer", "value": 55.42860594059401}, {"lowerIsBetter": false, "replicates": [28800.0], "unit": "score", "name": "RegExp", "value": 31.631423611111128}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19715.372671921228}]} 22:57:00 INFO - RETURN: dromaeo_css: 6259.77 22:57:00 INFO - RETURN: kraken: 1536.00 22:57:00 INFO - RETURN: v8_7: 19715.37 22:57:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19715.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6259.77"}}} 22:57:00 INFO - Return code: 0 22:57:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:57:00 ERROR - # TBPL SUCCESS # 22:57:00 INFO - Running post-action listener: _resource_record_post_action 22:57:00 INFO - Running post-run listener: _resource_record_post_run 22:57:01 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 509652992; Read time: 364; Write time: 421348 22:57:01 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 232112128; Read time: 156; Write time: 284956 22:57:01 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 277540864; Read time: 208; Write time: 136392 22:57:01 INFO - Running post-run listener: _upload_blobber_files 22:57:01 INFO - Blob upload gear active. 22:57:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:57:01 INFO - Copying logs to upload dir... 22:57:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.176303 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-11 22:57:00.890833) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:57:00.894493) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 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.009986 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.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 22:57:00.950319) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:57:00.950661) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1449881861.676073-328417738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 22:57:01.000039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 22:57:01.000356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 22:57:01.000729) ========= ========= Total master_lag: 0.23 =========