builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1450078117.64 results: success (0) buildid: 20151213223730 builduid: fa74701a8e86471b8c4985067d2eecc6 revision: 99137d6d4061f408ae0869122649d8bdf489cc30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.636343) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.637007) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.637412) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006502 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.678673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.679213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.706049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.706571) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.756796) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.757221) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.757717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.758131) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-13 23:28: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% 222M=0s 2015-12-13 23:28:38 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.207926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.979355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:37.979771) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.030322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.030738) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 99137d6d4061f408ae0869122649d8bdf489cc30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 99137d6d4061f408ae0869122649d8bdf489cc30 --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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-13 23:28:38,610 truncating revision to first 12 chars 2015-12-13 23:28:38,610 Setting DEBUG logging. 2015-12-13 23:28:38,610 attempt 1/10 2015-12-13 23:28:38,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/99137d6d4061?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-13 23:28:38,856 unpacking tar archive at: b2g-inbound-99137d6d4061/testing/mozharness/ program finished with exit code 0 elapsedTime=0.500802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.544909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.545287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.556206) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.556517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 23:28:38.557040) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2015-12-13 23:28:38.557384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:28:39 INFO - MultiFileLogger online at 20151213 23:28:39 in /builds/slave/test 23:28:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 23:28:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:28:39 INFO - {'append_to_log': False, 23:28:39 INFO - 'base_work_dir': '/builds/slave/test', 23:28:39 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 23:28:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:28:39 INFO - 'branch': 'B2G-Inbound-Non-PGO', 23:28:39 INFO - 'buildbot_json_path': 'buildprops.json', 23:28:39 INFO - 'config_files': ('talos/linux_config.py',), 23:28:39 INFO - 'default_actions': ('clobber', 23:28:39 INFO - 'read-buildbot-config', 23:28:39 INFO - 'download-and-extract', 23:28:39 INFO - 'populate-webroot', 23:28:39 INFO - 'create-virtualenv', 23:28:39 INFO - 'install', 23:28:39 INFO - 'run-tests'), 23:28:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:28:39 INFO - 'download_minidump_stackwalk': True, 23:28:39 INFO - 'download_symbols': 'ondemand', 23:28:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:28:39 INFO - 'tooltool.py': '/tools/tooltool.py', 23:28:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:28:39 INFO - '/tools/misc-python/virtualenv.py')}, 23:28:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:28:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:28:39 INFO - 'installer_path': 'installer.exe', 23:28:39 INFO - 'log_level': 'info', 23:28:39 INFO - 'log_name': 'talos', 23:28:39 INFO - 'log_to_console': True, 23:28:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:28:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:28:39 INFO - 'opt_config_files': (), 23:28:39 INFO - 'pip_index': False, 23:28:39 INFO - 'sps_profile': False, 23:28:39 INFO - 'sps_profile_interval': 0, 23:28:39 INFO - 'suite': 'dromaeojs', 23:28:39 INFO - 'system_bits': '64', 23:28:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:28:39 INFO - 'title': 'talos-linux64-ix-013', 23:28:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:28:39 INFO - 'use_talos_json': True, 23:28:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:28:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:28:39 INFO - 'work_dir': 'build'} 23:28:39 INFO - ##### 23:28:39 INFO - ##### Running clobber step. 23:28:39 INFO - ##### 23:28:39 INFO - Running pre-action listener: _resource_record_pre_action 23:28:39 INFO - Running main action method: clobber 23:28:39 INFO - rmtree: /builds/slave/test/build 23:28:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:28:39 INFO - Running post-action listener: _resource_record_post_action 23:28:39 INFO - ##### 23:28:39 INFO - ##### Running read-buildbot-config step. 23:28:39 INFO - ##### 23:28:39 INFO - Running pre-action listener: _resource_record_pre_action 23:28:39 INFO - Running main action method: read_buildbot_config 23:28:39 INFO - Using buildbot properties: 23:28:39 INFO - { 23:28:39 INFO - "properties": { 23:28:39 INFO - "buildnumber": 784, 23:28:39 INFO - "product": "firefox", 23:28:39 INFO - "script_repo_revision": "production", 23:28:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:28:39 INFO - "repository": "", 23:28:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 23:28:39 INFO - "buildid": "20151213223730", 23:28:39 INFO - "slavename": "talos-linux64-ix-013", 23:28:39 INFO - "pgo_build": "False", 23:28:39 INFO - "basedir": "/builds/slave/test", 23:28:39 INFO - "project": "", 23:28:39 INFO - "platform": "ubuntu64_hw", 23:28:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:28:39 INFO - "slavebuilddir": "test", 23:28:39 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 23:28:39 INFO - "branch": "b2g-inbound", 23:28:39 INFO - "repo_path": "integration/b2g-inbound", 23:28:39 INFO - "stage_platform": "linux64", 23:28:39 INFO - "builduid": "fa74701a8e86471b8c4985067d2eecc6", 23:28:39 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 23:28:39 INFO - }, 23:28:39 INFO - "sourcestamp": { 23:28:39 INFO - "repository": "", 23:28:39 INFO - "hasPatch": false, 23:28:39 INFO - "project": "", 23:28:39 INFO - "branch": "b2g-inbound-linux64-talos", 23:28:39 INFO - "changes": [ 23:28:39 INFO - { 23:28:39 INFO - "category": null, 23:28:39 INFO - "files": [ 23:28:39 INFO - { 23:28:39 INFO - "url": null, 23:28:39 INFO - "name": "https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 23:28:39 INFO - } 23:28:39 INFO - ], 23:28:39 INFO - "repository": "", 23:28:39 INFO - "rev": "99137d6d4061f408ae0869122649d8bdf489cc30", 23:28:39 INFO - "who": "philringnalda@gmail.com", 23:28:39 INFO - "when": 1450078085, 23:28:39 INFO - "number": 7356664, 23:28:39 INFO - "comments": "Merge m-c to b-i", 23:28:39 INFO - "project": "", 23:28:39 INFO - "at": "Sun 13 Dec 2015 23:28:05", 23:28:39 INFO - "branch": "b2g-inbound-linux64-talos", 23:28:39 INFO - "revlink": "", 23:28:39 INFO - "properties": [ 23:28:39 INFO - [ 23:28:39 INFO - "buildid", 23:28:39 INFO - "20151213223730", 23:28:39 INFO - "Change" 23:28:39 INFO - ], 23:28:39 INFO - [ 23:28:39 INFO - "builduid", 23:28:39 INFO - "fa74701a8e86471b8c4985067d2eecc6", 23:28:39 INFO - "Change" 23:28:39 INFO - ], 23:28:39 INFO - [ 23:28:39 INFO - "pgo_build", 23:28:39 INFO - "False", 23:28:39 INFO - "Change" 23:28:39 INFO - ] 23:28:39 INFO - ], 23:28:39 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 23:28:39 INFO - } 23:28:39 INFO - ], 23:28:39 INFO - "revision": "99137d6d4061f408ae0869122649d8bdf489cc30" 23:28:39 INFO - } 23:28:39 INFO - } 23:28:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 23:28:39 INFO - Running post-action listener: _resource_record_post_action 23:28:39 INFO - ##### 23:28:39 INFO - ##### Running download-and-extract step. 23:28:39 INFO - ##### 23:28:39 INFO - Running pre-action listener: _resource_record_pre_action 23:28:39 INFO - Running main action method: download_and_extract 23:28:39 INFO - mkdir: /builds/slave/test/build/tests 23:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:39 INFO - https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:28:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/test_packages.json 23:28:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/test_packages.json 23:28:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:28:42 INFO - Downloaded 1302 bytes. 23:28:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:28:42 INFO - Using the following test package requirements: 23:28:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:28:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:28:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'jsshell-linux-x86_64.zip'], 23:28:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:28:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:28:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:28:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:28:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:28:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:28:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:28:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:28: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')]} 23:28:42 INFO - https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:28:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:43 INFO - Downloaded 21869933 bytes. 23:28:43 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 23:28:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:43 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 23:28:45 INFO - Return code: 0 23:28:45 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 23:28: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')]} 23:28:45 INFO - https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:28:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:47 INFO - Downloaded 21869933 bytes. 23:28:47 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 23:28:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:28:47 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 23:28:48 INFO - Return code: 0 23:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:48 INFO - https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:51 INFO - Downloaded 11132038 bytes. 23:28:51 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 23:28:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:28:51 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 23:28:52 INFO - Return code: 0 23:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:52 INFO - https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeyDGGZVQO64ti8ik0xg7Q/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 23:28:54 INFO - Downloaded 57740900 bytes. 23:28:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:28:54 INFO - mkdir: /builds/slave/test/properties 23:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 23:28:54 INFO - Contents: 23:28:54 INFO - build_url:https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:28:54 INFO - Running post-action listener: _resource_record_post_action 23:28:54 INFO - Running post-action listener: set_extra_try_arguments 23:28:54 INFO - ##### 23:28:54 INFO - ##### Running populate-webroot step. 23:28:54 INFO - ##### 23:28:54 INFO - Running pre-action listener: _resource_record_pre_action 23:28:54 INFO - Running main action method: populate_webroot 23:28:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:28:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:28:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:28:54 INFO - '--tppagecycles', 23:28:54 INFO - '7'], 23:28:54 INFO - 'tests': ['tsvgm']}}, 23:28:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:28:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:28:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:28:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:28:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:28:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:28:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'tests': ['damp', 'tps']}, 23:28:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['damp', 'tps']}, 23:28:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:28:54 INFO - 'other': {'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'other_l64': {'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'other_nol64': {'tests': ['a11yr', 23:28:54 INFO - 'ts_paint', 23:28:54 INFO - 'tpaint', 23:28:54 INFO - 'sessionrestore', 23:28:54 INFO - 'sessionrestore_no_auto_restore']}, 23:28:54 INFO - 'svgr': {'tests': ['tsvgx', 23:28:54 INFO - 'tsvgr_opacity', 23:28:54 INFO - 'tart', 23:28:54 INFO - 'tscrollx', 23:28:54 INFO - 'cart']}, 23:28:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['tsvgx', 23:28:54 INFO - 'tsvgr_opacity', 23:28:54 INFO - 'tart', 23:28:54 INFO - 'tscrollx', 23:28:54 INFO - 'cart']}, 23:28:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'tests': ['tp5o']}, 23:28:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'talos_options': ['--e10s'], 23:28:54 INFO - 'tests': ['tp5o']}, 23:28:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'talos_options': ['--xperf_path', 23:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:28:54 INFO - 'tests': ['tp5n']}, 23:28:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:54 INFO - 'talos_options': ['--e10s', 23:28:54 INFO - '--xperf_path', 23:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:28:54 INFO - 'tests': ['tp5n']}}, 23:28:54 INFO - 'talos.zip': {'path': '', 23:28:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:28:54 INFO - Running post-action listener: _resource_record_post_action 23:28:54 INFO - ##### 23:28:54 INFO - ##### Running create-virtualenv step. 23:28:54 INFO - ##### 23:28:54 INFO - Running pre-action listener: _resource_record_pre_action 23:28:54 INFO - Running main action method: create_virtualenv 23:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 23:28:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:28:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:28:54 INFO - Using real prefix '/usr' 23:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:28:54 INFO - Installing distribute.............................................................................................................................................................................................done. 23:28:56 INFO - Installing pip.................done. 23:28:56 INFO - Return code: 0 23:28:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:28: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')]} 23:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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')]} 23:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:56 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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:28:56 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 23:28:56 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 23:28:56 INFO - Using env: {'DISPLAY': ':0', 23:28:56 INFO - 'HOME': '/home/cltbld', 23:28:56 INFO - 'LANG': 'en_US.UTF-8', 23:28:56 INFO - 'LANGUAGE': 'en_US:en', 23:28:56 INFO - 'LOGNAME': 'cltbld', 23:28:56 INFO - 'MAIL': '/var/mail/cltbld', 23:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:56 INFO - 'MOZ_NO_REMOTE': '1', 23:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:56 INFO - 'NO_EM_RESTART': '1', 23:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:56 INFO - 'PWD': '/builds/slave/test', 23:28:56 INFO - 'SHELL': '/bin/bash', 23:28:56 INFO - 'SHLVL': '1', 23:28:56 INFO - 'TERM': 'linux', 23:28:56 INFO - 'TMOUT': '86400', 23:28:56 INFO - 'USER': 'cltbld', 23:28:56 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:56 INFO - '_': '/tools/buildbot/bin/python'} 23:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:28:57 INFO - Cleaning up... 23:28:57 INFO - Return code: 0 23:28:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:28:57 INFO - Using env: {'DISPLAY': ':0', 23:28:57 INFO - 'HOME': '/home/cltbld', 23:28:57 INFO - 'LANG': 'en_US.UTF-8', 23:28:57 INFO - 'LANGUAGE': 'en_US:en', 23:28:57 INFO - 'LOGNAME': 'cltbld', 23:28:57 INFO - 'MAIL': '/var/mail/cltbld', 23:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:57 INFO - 'MOZ_NO_REMOTE': '1', 23:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:57 INFO - 'NO_EM_RESTART': '1', 23:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:57 INFO - 'PWD': '/builds/slave/test', 23:28:57 INFO - 'SHELL': '/bin/bash', 23:28:57 INFO - 'SHLVL': '1', 23:28:57 INFO - 'TERM': 'linux', 23:28:57 INFO - 'TMOUT': '86400', 23:28:57 INFO - 'USER': 'cltbld', 23:28:57 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:57 INFO - '_': '/tools/buildbot/bin/python'} 23:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:57 INFO - Downloading/unpacking psutil>=0.7.1 23:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:28:59 INFO - Installing collected packages: psutil 23:28:59 INFO - Running setup.py install for psutil 23:28:59 INFO - building 'psutil._psutil_linux' extension 23:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:28:59 INFO - building 'psutil._psutil_posix' extension 23:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:28:59 INFO - Successfully installed psutil 23:28:59 INFO - Cleaning up... 23:28:59 INFO - Return code: 0 23:28:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:28:59 INFO - Using env: {'DISPLAY': ':0', 23:28:59 INFO - 'HOME': '/home/cltbld', 23:28:59 INFO - 'LANG': 'en_US.UTF-8', 23:28:59 INFO - 'LANGUAGE': 'en_US:en', 23:28:59 INFO - 'LOGNAME': 'cltbld', 23:28:59 INFO - 'MAIL': '/var/mail/cltbld', 23:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:59 INFO - 'MOZ_NO_REMOTE': '1', 23:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:59 INFO - 'NO_EM_RESTART': '1', 23:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:59 INFO - 'PWD': '/builds/slave/test', 23:28:59 INFO - 'SHELL': '/bin/bash', 23:28:59 INFO - 'SHLVL': '1', 23:28:59 INFO - 'TERM': 'linux', 23:28:59 INFO - 'TMOUT': '86400', 23:28:59 INFO - 'USER': 'cltbld', 23:28:59 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:59 INFO - '_': '/tools/buildbot/bin/python'} 23:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:29:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:29:01 INFO - Installing collected packages: mozsystemmonitor 23:29:01 INFO - Running setup.py install for mozsystemmonitor 23:29:01 INFO - Successfully installed mozsystemmonitor 23:29:01 INFO - Cleaning up... 23:29:01 INFO - Return code: 0 23:29:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:01 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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29:01 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 23:29:01 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 23:29:01 INFO - Using env: {'DISPLAY': ':0', 23:29:01 INFO - 'HOME': '/home/cltbld', 23:29:01 INFO - 'LANG': 'en_US.UTF-8', 23:29:01 INFO - 'LANGUAGE': 'en_US:en', 23:29:01 INFO - 'LOGNAME': 'cltbld', 23:29:01 INFO - 'MAIL': '/var/mail/cltbld', 23:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:01 INFO - 'MOZ_NO_REMOTE': '1', 23:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:01 INFO - 'NO_EM_RESTART': '1', 23:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:01 INFO - 'PWD': '/builds/slave/test', 23:29:01 INFO - 'SHELL': '/bin/bash', 23:29:01 INFO - 'SHLVL': '1', 23:29:01 INFO - 'TERM': 'linux', 23:29:01 INFO - 'TMOUT': '86400', 23:29:01 INFO - 'USER': 'cltbld', 23:29:01 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:01 INFO - '_': '/tools/buildbot/bin/python'} 23:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:29:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:29:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:29:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:04 INFO - Downloading docopt-0.6.1.tar.gz 23:29:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:29:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:29:04 INFO - Running setup.py install for blobuploader 23:29:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:29:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:29:04 INFO - Running setup.py install for requests 23:29:04 INFO - Running setup.py install for docopt 23:29:04 INFO - Successfully installed blobuploader requests docopt 23:29:04 INFO - Cleaning up... 23:29:04 INFO - Return code: 0 23:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:04 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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29:04 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 23:29:04 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 23:29:04 INFO - Using env: {'DISPLAY': ':0', 23:29:04 INFO - 'HOME': '/home/cltbld', 23:29:04 INFO - 'LANG': 'en_US.UTF-8', 23:29:04 INFO - 'LANGUAGE': 'en_US:en', 23:29:04 INFO - 'LOGNAME': 'cltbld', 23:29:04 INFO - 'MAIL': '/var/mail/cltbld', 23:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:04 INFO - 'MOZ_NO_REMOTE': '1', 23:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:04 INFO - 'NO_EM_RESTART': '1', 23:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:04 INFO - 'PWD': '/builds/slave/test', 23:29:04 INFO - 'SHELL': '/bin/bash', 23:29:04 INFO - 'SHLVL': '1', 23:29:04 INFO - 'TERM': 'linux', 23:29:04 INFO - 'TMOUT': '86400', 23:29:04 INFO - 'USER': 'cltbld', 23:29:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:04 INFO - '_': '/tools/buildbot/bin/python'} 23:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:05 INFO - Running setup.py (path:/tmp/pip-NRblmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:05 INFO - Running setup.py (path:/tmp/pip-AxXdrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:05 INFO - Running setup.py (path:/tmp/pip-Ho46QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:05 INFO - Running setup.py (path:/tmp/pip-MRymQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:05 INFO - Running setup.py (path:/tmp/pip-QJQy_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:05 INFO - Running setup.py (path:/tmp/pip-S3IwCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:05 INFO - Running setup.py (path:/tmp/pip-0iLpH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:05 INFO - Running setup.py (path:/tmp/pip-wrSa6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:05 INFO - Running setup.py (path:/tmp/pip-I6T_k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:05 INFO - Running setup.py (path:/tmp/pip-3vLCY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:05 INFO - Running setup.py (path:/tmp/pip-4ELTQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:05 INFO - Running setup.py (path:/tmp/pip-Q9gScz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:06 INFO - Running setup.py (path:/tmp/pip-YFmIIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:06 INFO - Running setup.py (path:/tmp/pip-D1UaGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:06 INFO - Running setup.py (path:/tmp/pip-1ejFVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:06 INFO - Running setup.py (path:/tmp/pip-LpVby0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:06 INFO - Running setup.py (path:/tmp/pip-RaCt2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:29:06 INFO - Running setup.py install for manifestparser 23:29:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:29:06 INFO - Running setup.py install for mozcrash 23:29:06 INFO - Running setup.py install for mozdebug 23:29:06 INFO - Running setup.py install for mozdevice 23:29:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:29:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:29:06 INFO - Running setup.py install for mozfile 23:29:06 INFO - Running setup.py install for mozhttpd 23:29:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozinfo 23:29:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozInstall 23:29:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozleak 23:29:07 INFO - Running setup.py install for mozlog 23:29:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for moznetwork 23:29:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozprocess 23:29:07 INFO - Running setup.py install for mozprofile 23:29:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozrunner 23:29:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:29:07 INFO - Running setup.py install for mozscreenshot 23:29:07 INFO - Running setup.py install for moztest 23:29:08 INFO - Running setup.py install for mozversion 23:29:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:29:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:08 INFO - Cleaning up... 23:29:08 INFO - Return code: 0 23:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:08 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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29:08 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 23:29:08 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 23:29:08 INFO - Using env: {'DISPLAY': ':0', 23:29:08 INFO - 'HOME': '/home/cltbld', 23:29:08 INFO - 'LANG': 'en_US.UTF-8', 23:29:08 INFO - 'LANGUAGE': 'en_US:en', 23:29:08 INFO - 'LOGNAME': 'cltbld', 23:29:08 INFO - 'MAIL': '/var/mail/cltbld', 23:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:08 INFO - 'MOZ_NO_REMOTE': '1', 23:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:08 INFO - 'NO_EM_RESTART': '1', 23:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:08 INFO - 'PWD': '/builds/slave/test', 23:29:08 INFO - 'SHELL': '/bin/bash', 23:29:08 INFO - 'SHLVL': '1', 23:29:08 INFO - 'TERM': 'linux', 23:29:08 INFO - 'TMOUT': '86400', 23:29:08 INFO - 'USER': 'cltbld', 23:29:08 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:08 INFO - '_': '/tools/buildbot/bin/python'} 23:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:08 INFO - Running setup.py (path:/tmp/pip-AZPBXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:08 INFO - Running setup.py (path:/tmp/pip-ALC2kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:08 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)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:08 INFO - Running setup.py (path:/tmp/pip-5mvw5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:08 INFO - Running setup.py (path:/tmp/pip-sSmIFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:08 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)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:08 INFO - Running setup.py (path:/tmp/pip-HyW5qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:08 INFO - Running setup.py (path:/tmp/pip-P5u3kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:08 INFO - Running setup.py (path:/tmp/pip-A9JBMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:08 INFO - Running setup.py (path:/tmp/pip-rvknmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:08 INFO - Running setup.py (path:/tmp/pip-i742jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:08 INFO - Running setup.py (path:/tmp/pip-4i0XuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:09 INFO - Running setup.py (path:/tmp/pip-Y2gQV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:09 INFO - Running setup.py (path:/tmp/pip-i6MVer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:09 INFO - Running setup.py (path:/tmp/pip-657AZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:09 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)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:09 INFO - Running setup.py (path:/tmp/pip-Stglwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:09 INFO - Running setup.py (path:/tmp/pip-yP9AH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:09 INFO - Running setup.py (path:/tmp/pip-Wy1Ahl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:09 INFO - Running setup.py (path:/tmp/pip-URUrl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:29:09 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)) 23:29:09 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)) 23:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:29:09 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)) 23:29:09 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)) 23:29:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:11 INFO - Downloading blessings-1.5.1.tar.gz 23:29:11 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 23:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:29:11 INFO - Installing collected packages: blessings 23:29:11 INFO - Running setup.py install for blessings 23:29:11 INFO - Successfully installed blessings 23:29:11 INFO - Cleaning up... 23:29:11 INFO - Return code: 0 23:29:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:29:11 INFO - Reading from file tmpfile_stdout 23:29:11 INFO - Current package versions: 23:29:11 INFO - argparse == 1.2.1 23:29:11 INFO - blessings == 1.5.1 23:29:11 INFO - blobuploader == 1.2.4 23:29:11 INFO - docopt == 0.6.1 23:29:11 INFO - manifestparser == 1.1 23:29:11 INFO - mozInstall == 1.12 23:29:11 INFO - mozcrash == 0.16 23:29:11 INFO - mozdebug == 0.1 23:29:11 INFO - mozdevice == 0.47 23:29:11 INFO - mozfile == 1.2 23:29:11 INFO - mozhttpd == 0.7 23:29:11 INFO - mozinfo == 0.9 23:29:11 INFO - mozleak == 0.1 23:29:11 INFO - mozlog == 3.1 23:29:11 INFO - moznetwork == 0.27 23:29:11 INFO - mozprocess == 0.22 23:29:11 INFO - mozprofile == 0.27 23:29:11 INFO - mozrunner == 6.11 23:29:11 INFO - mozscreenshot == 0.1 23:29:11 INFO - mozsystemmonitor == 0.0 23:29:11 INFO - moztest == 0.7 23:29:11 INFO - mozversion == 1.4 23:29:11 INFO - psutil == 3.1.1 23:29:11 INFO - requests == 1.2.3 23:29:11 INFO - wsgiref == 0.1.2 23:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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', '-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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29:11 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 23:29:11 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 23:29:11 INFO - Using env: {'DISPLAY': ':0', 23:29:11 INFO - 'HOME': '/home/cltbld', 23:29:11 INFO - 'LANG': 'en_US.UTF-8', 23:29:11 INFO - 'LANGUAGE': 'en_US:en', 23:29:11 INFO - 'LOGNAME': 'cltbld', 23:29:11 INFO - 'MAIL': '/var/mail/cltbld', 23:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:11 INFO - 'MOZ_NO_REMOTE': '1', 23:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:11 INFO - 'NO_EM_RESTART': '1', 23:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:11 INFO - 'PWD': '/builds/slave/test', 23:29:11 INFO - 'SHELL': '/bin/bash', 23:29:11 INFO - 'SHLVL': '1', 23:29:11 INFO - 'TERM': 'linux', 23:29:11 INFO - 'TMOUT': '86400', 23:29:11 INFO - 'USER': 'cltbld', 23:29:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:11 INFO - '_': '/tools/buildbot/bin/python'} 23:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 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)) 23:29:11 INFO - Cleaning up... 23:29:11 INFO - Return code: 0 23:29:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29: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', 'jsonschema'] in /builds/slave/test/build 23:29: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 jsonschema 23:29:11 INFO - Using env: {'DISPLAY': ':0', 23:29:11 INFO - 'HOME': '/home/cltbld', 23:29:11 INFO - 'LANG': 'en_US.UTF-8', 23:29:11 INFO - 'LANGUAGE': 'en_US:en', 23:29:11 INFO - 'LOGNAME': 'cltbld', 23:29:11 INFO - 'MAIL': '/var/mail/cltbld', 23:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:11 INFO - 'MOZ_NO_REMOTE': '1', 23:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:11 INFO - 'NO_EM_RESTART': '1', 23:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:11 INFO - 'PWD': '/builds/slave/test', 23:29:11 INFO - 'SHELL': '/bin/bash', 23:29:11 INFO - 'SHLVL': '1', 23:29:11 INFO - 'TERM': 'linux', 23:29:11 INFO - 'TMOUT': '86400', 23:29:11 INFO - 'USER': 'cltbld', 23:29:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:11 INFO - '_': '/tools/buildbot/bin/python'} 23:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:12 INFO - Downloading/unpacking jsonschema 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:29:13 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 23:29:13 INFO - Downloading/unpacking functools32 (from jsonschema) 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:13 INFO - Downloading functools32-3.2.3-2.tar.gz 23:29:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:29:14 INFO - warning: no files found matching '*.txt' 23:29:14 INFO - no previously-included directories found matching 'build' 23:29:14 INFO - no previously-included directories found matching 'dist' 23:29:14 INFO - no previously-included directories found matching '.git*' 23:29:14 INFO - Installing collected packages: jsonschema, functools32 23:29:14 INFO - Running setup.py install for functools32 23:29:14 INFO - warning: no files found matching '*.txt' 23:29:14 INFO - no previously-included directories found matching 'build' 23:29:14 INFO - no previously-included directories found matching 'dist' 23:29:14 INFO - no previously-included directories found matching '.git*' 23:29:14 INFO - Successfully installed jsonschema functools32 23:29:14 INFO - Cleaning up... 23:29:14 INFO - Return code: 0 23:29:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:14 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 0x7f2d93a83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, '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': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:29:14 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 23:29:14 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 23:29:14 INFO - Using env: {'DISPLAY': ':0', 23:29:14 INFO - 'HOME': '/home/cltbld', 23:29:14 INFO - 'LANG': 'en_US.UTF-8', 23:29:14 INFO - 'LANGUAGE': 'en_US:en', 23:29:14 INFO - 'LOGNAME': 'cltbld', 23:29:14 INFO - 'MAIL': '/var/mail/cltbld', 23:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:14 INFO - 'MOZ_NO_REMOTE': '1', 23:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:14 INFO - 'NO_EM_RESTART': '1', 23:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:14 INFO - 'PWD': '/builds/slave/test', 23:29:14 INFO - 'SHELL': '/bin/bash', 23:29:14 INFO - 'SHLVL': '1', 23:29:14 INFO - 'TERM': 'linux', 23:29:14 INFO - 'TMOUT': '86400', 23:29:14 INFO - 'USER': 'cltbld', 23:29:14 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:14 INFO - '_': '/tools/buildbot/bin/python'} 23:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:14 INFO - Downloading/unpacking flake8 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:29:16 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 23:29:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:29:16 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 23:29:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 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 23:29:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:29:16 INFO - no previously-included directories found matching 'docs/_build' 23:29:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:29:16 INFO - Running setup.py install for pep8 23:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:29:16 INFO - no previously-included directories found matching 'docs/_build' 23:29:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:29:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:29:16 INFO - Cleaning up... 23:29:17 INFO - Return code: 0 23:29:17 INFO - Running post-action listener: _resource_record_post_action 23:29:17 INFO - Running post-action listener: _start_resource_monitoring 23:29:17 INFO - Starting resource monitoring. 23:29:17 INFO - ##### 23:29:17 INFO - ##### Running install step. 23:29:17 INFO - ##### 23:29:17 INFO - Running pre-action listener: _resource_record_pre_action 23:29:17 INFO - Running main action method: install 23:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:29:17 INFO - Reading from file tmpfile_stdout 23:29:17 INFO - Detecting whether we're running mozinstall >=1.0... 23:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:29:17 INFO - Reading from file tmpfile_stdout 23:29:17 INFO - Output received: 23:29:17 INFO - Usage: mozinstall [options] installer 23:29:17 INFO - Options: 23:29:17 INFO - -h, --help show this help message and exit 23:29:17 INFO - -d DEST, --destination=DEST 23:29:17 INFO - Directory to install application into. [default: 23:29:17 INFO - "/builds/slave/test"] 23:29:17 INFO - --app=APP Application being installed. [default: firefox] 23:29:17 INFO - mkdir: /builds/slave/test/build/application 23:29:17 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'] 23:29:17 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 23:29:37 INFO - Reading from file tmpfile_stdout 23:29:37 INFO - Output received: 23:29:37 INFO - /builds/slave/test/build/application/firefox/firefox 23:29:37 INFO - Running post-action listener: _resource_record_post_action 23:29:37 INFO - ##### 23:29:37 INFO - ##### Running run-tests step. 23:29:37 INFO - ##### 23:29:37 INFO - Running pre-action listener: _resource_record_pre_action 23:29:37 INFO - Running main action method: run_tests 23:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:29:37 INFO - Python 2.7.3 23:29:37 INFO - Return code: 0 23:29:37 INFO - grabbing minidump binary from tooltool 23:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:37 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 0x1e2c0b0>, '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 0x1e2cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:29:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:29:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:29:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:29:37 INFO - Return code: 0 23:29:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:29:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:29:45 INFO - Return code: 0 23:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test/build 23:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 23:29:45 INFO - Using env: {'DISPLAY': ':0', 23:29:45 INFO - 'HOME': '/home/cltbld', 23:29:45 INFO - 'LANG': 'en_US.UTF-8', 23:29:45 INFO - 'LANGUAGE': 'en_US:en', 23:29:45 INFO - 'LOGNAME': 'cltbld', 23:29:45 INFO - 'MAIL': '/var/mail/cltbld', 23:29:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:29:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:45 INFO - 'MOZ_NO_REMOTE': '1', 23:29:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:45 INFO - 'NO_EM_RESTART': '1', 23:29:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:45 INFO - 'PWD': '/builds/slave/test', 23:29:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:29:45 INFO - 'SHELL': '/bin/bash', 23:29:45 INFO - 'SHLVL': '1', 23:29:45 INFO - 'TERM': 'linux', 23:29:45 INFO - 'TMOUT': '86400', 23:29:45 INFO - 'USER': 'cltbld', 23:29:45 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081', 23:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:45 INFO - '_': '/tools/buildbot/bin/python'} 23:29:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 23:29:47 INFO - mozversion INFO | application_buildid: 20151213223730 23:29:47 INFO - mozversion INFO | application_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 23:29:47 INFO - mozversion INFO | application_display_name: Nightly 23:29:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:29:47 INFO - mozversion INFO | application_name: Firefox 23:29:47 INFO - mozversion INFO | application_remotingname: firefox 23:29:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:29:47 INFO - mozversion INFO | application_vendor: Mozilla 23:29:47 INFO - mozversion INFO | application_version: 45.0a1 23:29:47 INFO - mozversion INFO | platform_buildid: 20151213223730 23:29:47 INFO - mozversion INFO | platform_changeset: 99137d6d4061f408ae0869122649d8bdf489cc30 23:29:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:29:47 INFO - mozversion INFO | platform_version: 45.0a1 23:29:47 INFO - 2015-12-13 23:29:47,072 DEBUG : using testdate: 1450078187 23:29:47 INFO - 2015-12-13 23:29:47,072 DEBUG : actual date: 1450078187 23:29:47 INFO - 2015-12-13 23:29:47,081 INFO : starting webserver on 'localhost:41840' 23:29:47 INFO - 2015-12-13 23:29:47,082 INFO : Starting test suite talos-linux64-ix-013 23:29:47 INFO - 2015-12-13 23:29:47,082 INFO : Starting test dromaeo_css 23:29:47 INFO - 2015-12-13 23:29:47,082 DEBUG : operating with platform_type : linux_ 23:29:47 INFO - 2015-12-13 23:29:47,082 INFO : Initialising browser for dromaeo_css test... 23:29:47 INFO - 2015-12-13 23:29:47,095 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm92lKe/profile http://localhost:41840/getInfo.html 23:30:43 INFO - 2015-12-13 23:30:43,873 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:30:43 INFO - 2015-12-13 23:30:43,873 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:30:43 INFO - 2015-12-13 23:30:43,873 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:30:43 INFO - 2015-12-13 23:30:43,873 DEBUG : BROWSER_OUTPUT: __metrics 23:30:44 INFO - 2015-12-13 23:30:44,378 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] 23:30:44 INFO - 2015-12-13 23:30:44,475 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] 23:30:49 INFO - 2015-12-13 23:30:49,129 INFO : Browser initialized. 23:30:49 INFO - 2015-12-13 23:30:49,130 INFO : Running cycle 1/1 for dromaeo_css test... 23:30:49 INFO - 2015-12-13 23:30:49,130 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm92lKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:31:01 INFO - 2015-12-13 23:31:01,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 142737408 23:31:01 INFO - 2015-12-13 23:31:01,260 DEBUG : BROWSER_OUTPUT: 23:31:52 INFO - 2015-12-13 23:31:52,749 DEBUG : BROWSER_OUTPUT: 1450078312746 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:34:08 INFO - 2015-12-13 23:34:08,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41840/tests/dromaeo/cssquery-ext.html) 23:34:09 INFO - 2015-12-13 23:34:09,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 242786304 23:34:09 INFO - 2015-12-13 23:34:09,380 DEBUG : BROWSER_OUTPUT: 23:37:12 INFO - 2015-12-13 23:37:12,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-ext.html (next: http://localhost:41840/tests/dromaeo/cssquery-jquery.html) 23:37:12 INFO - 2015-12-13 23:37:12,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 221118464 23:37:12 INFO - 2015-12-13 23:37:12,646 DEBUG : BROWSER_OUTPUT: 23:40:14 INFO - 2015-12-13 23:40:14,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41840/tests/dromaeo/cssquery-mootools.html) 23:40:15 INFO - 2015-12-13 23:40:15,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 215306240 23:40:15 INFO - 2015-12-13 23:40:15,215 DEBUG : BROWSER_OUTPUT: 23:43:17 INFO - 2015-12-13 23:43:17,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41840/tests/dromaeo/cssquery-prototype.html) 23:43:17 INFO - 2015-12-13 23:43:17,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 200466432 23:43:17 INFO - 2015-12-13 23:43:17,774 DEBUG : BROWSER_OUTPUT: 23:46:20 INFO - 2015-12-13 23:46:20,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41840/tests/dromaeo/cssquery-yui.html) 23:46:21 INFO - 2015-12-13 23:46:21,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 205905920 23:46:21 INFO - 2015-12-13 23:46:21,101 DEBUG : BROWSER_OUTPUT: 23:49:23 INFO - 2015-12-13 23:49:23,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/dromaeo/cssquery-yui.html (next: http://localhost:41840/tests/dromaeo/cssquery-dojo.html) 23:49:24 INFO - 2015-12-13 23:49:24,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 248881152 23:49:24 INFO - 2015-12-13 23:49:24,141 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,144 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:49:24 INFO - 2015-12-13 23:49:24,144 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:49:24 INFO - 2015-12-13 23:49:24,144 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:49:24 INFO - 2015-12-13 23:49:24,144 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:49:24 INFO - 2015-12-13 23:49:24,146 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2604.479104179164;2718.320419895026;2732.7540521353085;2739.835609863409;2745.8489783061923;4577.931331030038;4709.340692303072;4746.810127594897;4768.30859525369;4777.665563410558;4644.930326045103;4712.104700106977;4741.8103275868925;4751.833685820997;4886.584640305569;4364.956350436495;4366.279563871974;4424.933625995613;4492.618127459154;4533.0253995390985;4446.622037126832;4500.234960056799;4518.615917646987;4520.570545798144;4565.61192298655;4215.43091682622;4263.701540892139;4320;4327.437433133672;4413.801378937924;4412.580804823537;4415;4418.226810308183;4427.845025424094;4453.332000199964;4376.759278239696;4387.232234358974;4396.538363471821;4405.471343438776;4439.2675208590545;4494.73031618104;4610.838620648261;4615.215413379734;4625.352450656911;4750.904981900343;5108.489151084899;5112.054269960032;5121.871953201163;5172.9741351293005;5189.2475591039465;5122.052420302256;5130.333056702605;5131.230315452674;5135.6148288878485;5182.455842136559;4581.152486789954;4676.485586585541;4680.227762419231;4722.834700785456;4737.1946769049;4979.701217926936;5071.822486212965;5090.185570308733;5099.4390617032095;5127.4872512748425;5021.84934451967;5029.371328583927;5034.471380505068;5035.571976381975;5079.974600126976;4872.610191184696;4977.253411988158;4989.451160372356;5120.795168193231;5133.409657889316;5042.949570504248;5132.435432102466;5135.229715542624;5135.666181698252;5160.819371322061;5027.4469808321055;5049.091163590589;5053.570446512088;5056.394808396857;5099.158638824627;3965.5637879833193;4096.938545921814;4100.138970816162;4214.768187749642;4259.403683484315;3615.6565126312958;3671.2657468506404;3681.5398075240596;3688.133288677159;3712.406015037581;4395.1868904252815;4404.4494438195225;4407.140607581491;4410.360497727812;4452.1763473757455;4870.488598697157;4991.950080499221;4994.051130285234;5146.305248791366;5193.584513238932;4300.634446072057;4357.9128417431475;4358.564143585616;4388.363687265329;4405.7797110144365;4505.7521836298665;4512.435945506812;4534.7052441591195;4537.251353526697;4545.499995000548;4710.528947105262;4822.156122678447;4823.831165909176;4841.878953026203;4867.123917694849;5017.573506251863;5077.365329333833;5096.923546146885;5106.183010718267;5130.230465430215;4865.197242455097;4868.245421959602;4871.318015477907;4872.805087796449;4918.213085906238;4897.975510122426;5077.289179514797;5080.441151473409;5081.8729531762;5118.38579370478;5016.949830501649;5021.799128034838;5055.974720126376;5128.128218202989;5174.430812610534;4956.083124621957;4958.652894297365;4987.80048798044;4993.825216117419;5033.144365457808;4709.576138147583;4944.8763780905765;4958.925616115834;4962.057209130398;4963.8262660806695;4716.056788642217;4775.877668747911;4792.257200133985;4860.756962151808;4876.853694389174;5020.723860187724;5033.245013248042;5033.773480193473;5035.798568057383;5036.84889453317;4718.787654555485;4927.704337739747;4928.186849169847;4931.5315045070665;4971.850844474671 23:49:24 INFO - 2015-12-13 23:49:24,147 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.1419281877297;560.5263552298306;569.7920259105426;587.6092398554961;590.9704514774262;26700.59949100765;36442.817785911066;37002.8149859251;37051.629483705154;37093.44359834598;40282.19435611293;40867.38698919518;40871;40880.59119408805;40936.59063409365;7004;7132.536385134949;7891.684332626703;8065.838683226332;8066;10188.898111018907;10395.532201050972;10475.68572942809;10486.423246721428;10503.579856805718;10067.29528932975;10177.389356638625;10183.745406364826;10187.949060254688;10197.286189966706;7040.3663670269925;7287.672054757549;10117.949410252939;10231.488425578691;10241.948790256001;10172.186225102048;10429.791404171874;10459.320144190604;10463.68608941733;10463.895361046369;37199.25601487955;37707.811460942794;37708.81145594282;37782.62217377819;37829;2956.6156399667907;2966.9703302967127;3041.863116159778;3228;3446.9655303446893;28038.579421308696;28206.153815385573;28294.717052829415;28449.146525604265;28538.429231415255;3376.8142752148624;3472.3923313420305;3497.842597083137;3500.3874321993803;3603.063203567065;217534;218807;219486;219853;220040.9999999984;50503;51578.74210628998;56022.43977560172;56076.71961640166;59726;54950;54955;55244.44755552473;55275.44724552703;55372.72313638406;12846.164999275017;12981.286029268293;12996.415161317575;13003.869961300266;13004.349782511026;8843.248323892542;9315.441073535609;9489.1934185595;9631.229501639851;9902.7029189123;19106.2357505701;19379.80620193808;19467.61064778725;19498.220071197276;19510.90244548768;7797.401532685786;7972.441929065026;8038.517688938682;8096.7166149184495;8116.431849770459;833.4374297349265;875.2560323724911;877.7322916510398;983.2772911909741;1059.0045357364206;26339.07813226528;26578.468430631277;26715.465690686076;26724.19827405181;26728;975.380633297861;989.1641562879355;1039.8180318444242;1109.5229051507768;1137.9487923043318;13913.58259252224;14250.786238206436;14330.928345358207;15144.242787860563;16023.759643605355;318409;323938;325710;326115;326427;49183.26225106555;49400.50599494031;49762.75118624384;49857.25214121791;49891.50108498941;1203.1517779965104;1228.42264135856;1248.332142303863;1252.7807633664072;1253.8934190593902;26663.600045998937;27422.45155096927;27721.722782772722;28126;28213;38866;39376.803115984236;39382.40926386049;39385.606143938196;39420;246798;249219;249352;249541;249579;25803.741962580883;26393.868030659723;28714.42571148607;28727.281817954718;29101.417971640025;32835.67164328326;45087.54912450833;46656.533434665216;46866.53133468622;47745.28382074202;33075.83462082674;33171.17072073121;33788.66211337855;34439.31121377608;34629.653703462645;27741;32400.513992289663;35883.82058089693;37827.24345513129;39511.80244098761;33129;38219.808900955315;39054.4141837867;39119.41320880132;40011.1997760049;29235.85382073076;30145;30662.693373065984;30699.846500768246;30859.84570077225;23621;23698.881505592362;23994.76005239995;24000.39999000039;24113.27660170198 23:49:24 INFO - 2015-12-13 23:49:24,150 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.1353633176579;334.096269590757;334.57676039809644;335.16878142207327;335.4833556323262;12670.493180272779;12951.222926624409;15068.623284417881;15405.383784648615;15944.999999999985;10000.749981250472;10271.743206419844;10647.627333043345;15109.84890151098;15135.167565783877;4561.338605902142;4660.37084993525;4685.039566888797;4690.319903613974;4693.953060469403;5008.248762685608;5080.491950804909;5086.3387759591205;5087.109755792721;5087.49125087492;5015.69905805651;5027.949720502803;5052.040112378636;5053.317802096725;5054.1660625996665;4901.53435423636;5005.274235235906;5014.398272207341;5014.52362025607;5019.52314530119;4509.954900451019;4510;4511.909761804745;4515.142122996653;4516.6612504061995;11966.64100076999;12047.93976030123;12056.095792815486;12067.396630168456;14719.89600779935;1779.9110044497722;1791.7849858016991;1805.0974512743628;1847.990760046191;1958.3537432647192;9267.768305792342;9889.109980101824;10366.792664146675;12926.353682315847;13036.674083147902;1704.5056933489273;1729.9221535030829;1749.6850566897954;1764.4882983934644;1787.642471505704;54849;56836.431635683526;56843;56990.715046424506;58659.706701466646;9812.852807207897;9841.950790246003;9898.356606820533;9969.152622027064;10085.243606729524;10585.523651435704;10842.241043127064;12321.260724356389;12339.814902776465;12353.691157721129;6417.262014868256;6638.933610663928;6664.433523150587;6698.162729658793;6727.798166055026;6493.967530162414;6494.870102597922;6552.180977377828;6584;6629.801105966829;3934.488516492838;4033.979830100831;4044.51465824103;4052.513698356157;4072.429859819628;1721.9483415497555;1740.4691569071554;1741.7474466202584;1774.9556261093576;1779.4839496545856;808.1554775259867;842.9704960326359;847.3306088190384;863.0075413274784;956.6125719083782;15630.296636651377;15822.287997040161;15835.762463563056;16130.354785808437;16223;826.557791581501;838.7567605394489;840.5587066789984;923.353652443279;980.632262901412;8963.282937364995;9346.712720343117;9762.560684769202;9809.607615695293;9868.753281168028;525216;525371;532217;544100;545182;73496.63251683814;74424;74866;75901.24098758942;77030.22969770343;1044.681372181492;1050.7425680708275;1154.6132045764764;1179.7581495793343;1180.4097951024487;14641.560753177422;14836.10983341003;14948.626284342978;15008.624784380478;15151.469698560497;22712.145591189692;30976.380472390876;32185.839070805432;34848.65151348556;35172;40827.59172408238;41944.3708344369;43124.56875431331;43297.78351108224;43558.346624801285;8829.426087304304;8875.689350872946;8933.240674542736;9008.684696035607;9111.088891110836;10636.52135653913;10708.196885233794;10751.301165424222;10787.190960678137;10846.403447810446;11345.716357091138;13902.652433688834;14033.578992630237;14198.716025679636;14496.565103046925;13254.469821207043;13341.799873001719;13635.590932272047;13670.11144275619;14136.929315353358;9902.801943961225;11270.83093753578;13406.530771422953;13605.591832245049;13666.658333541742;8702.695405660772;8706.91293087061;8848.070952550148;8848.734537963872;8889.022207557293;10327.431991240554;12726.618201453972;12904.483820647445;13631.24033714045;13651.249181295125 23:49:24 INFO - 2015-12-13 23:49:24,151 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1259.8551166615841;1409.2953523238382;1421.6161636358183;1551.3561871823194;1728.118659483663;6345.968270158649;7215.098112735908;7409.4072474202;7410.629468526579;7433.256674332564;7009.7897063088185;7015.6141412222305;7053;7071.85856282874;7075.646217689121;1771.8139595342498;1813.1206364913007;2122.7134336864556;2169.7504786949467;2173.5870184664864;2096.741954827107;2145.442185031895;2146.227358151072;2146.828253739697;2149.279991202941;2018.3440381875876;2030.8883011434366;2074.408793493855;2084.218418093215;2087.937361879146;2109;2134.839887008465;2136.433845031068;2163.1671806354666;2164.7402311722535;2115.1010820401266;2141.7751136130637;2144.2495126705685;2144.2602302205714;2146.195176808697;7270.963645181793;7364.226756190576;7399.445041621846;7399.445041621846;7405.74079907206;4172.666186705087;4226.66186705066;4235.745855248695;4244.72409293395;4257.340112282601;2662.560677488212;2713.606527053586;2719.5104881121392;2729.9181024569293;2740.082072505713;885.2298500304776;889.3774357949461;891.0376793063541;900.7477906186213;924.4222361024359;9667.419954802734;9686.999999999929;9698.272629552812;9700.175485083706;9709.417434953926;3915.9021024474614;3971.801409929492;4020.296448121567;4020.3567429211184;4024.335984562573;8348.833023339621;8352.206540378655;8353.415260931677;8371.706990255434;8388.32893368529;4306;4308.569143085666;4319.416878721395;4341.522432532419;4345.869623911288;3954;3954.130091379892;3955.268275369066;3956.8812935611977;3979.3633018716864;3028.409460155249;3062.5406189071373;3147.4806656901355;3429.0570093224565;3515.5078289039557;1069.9358038517714;1070.7323169207698;1072.3994563044564;1083.8970297821695;1086.559943222996;829.8713699376606;834.8038211020405;835.0480452284401;915.2266334946959;959.0840747086515;6887.173539175331;6930.584164950119;6934.826629334206;6972.721091156297;6975.476839237078;1008.566316483919;1030.3302853145515;1036.108946306176;1048.219076787798;1050.8686414198226;5304.23088652151;5376.838694839161;5387.649802762886;5392.973035134799;5410.269613602113;8697.739067827975;8873.600687969058;9069.818603628022;9100.499472528942;9106.908930910738;8900.73297801067;8964.238039766562;8982.101789821096;9001.909980900238;9002.504862232508;6684.2981486944145;6717.395434410829;6784.76253331131;6847.281035491302;7017.999999999898;6583.407493325623;6618.768343107968;6622.072909792537;6630.701618427086;6636.83407914806;7857.528548286892;8032.317253033324;8067.919320806717;8068.314193293636;8085.555294458862;8053.516788992679;8177.6320065596;8221.83556328882;8278.337732981467;8327.333813294801;5866.50134738535;6503.219613646393;6555.2789193189665;6555.3772391622715;6558.147440832661;5925.288965324189;6090.695465226632;6416.294207637063;6423.0686550450855;6471.676416179266;6538.346165383614;6566.671666416755;6668.533202675961;6671.5997040177745;6707.1616047994;6423.229212494531;6429.582077165156;6477.481801455967;6510.967445162744;6535.150430444202;6664.200295964515;6703.530752847449;6726.7981960541265;6731.024001519654;6744.898826517704;6131.356207598138;6156.199694039746;6164.722587483484;6173;6177.567570270038;6012.669303188367;6169.784057557964;6172.938270617236;6175.104609831459;6204.627722336674 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.9726424621784;309.33338655198054;309.71196786988105;310.10689215060637;316.1274881327535;5471.808486702967;5487.835364939053;5489.725513724317;5493.807716729915;5549.278593782813;5146.665466744659;5262.81580144695;5300;5429.4570542945785;5465.9726701366435;4264.87205383839;4271.957280427203;4276.893077673052;4278.4010238566625;4288.807003684826;4035;4276.059266961263;4279.700420970534;4280;4283.207606592775;4090.1819636072755;4114.526829414611;4190.727602705814;4200.474940632421;4208.873733787991;4173.332266837307;4189.853355132555;4195.433616461769;4200.075983283673;4207.179599978005;3718.0518967663074;3752.4934133891848;3757.910206040245;3759.172981943995;3764.3224219640456;5085.288059671649;5133.486651334874;5149.639525233235;5151.278820965068;5155.536001759822;4760.833370832039;4900.485449027837;4917.139500587383;4926.014797040606;4928.827491037797;5762.798302059407;5776.855578610526;5782;5785;5785.855353616151;4077.796110194508;4079.1637714268504;4085.060436099684;4085.22380747657;4085.2238074765996;5932.822015339547;5970.701464926779;6072.301685306158;6078.300995385543;6083.634981901056;4226.492820861455;4231;4231.7672528010635;4237.110206856594;4242.236397448427;4294.914101718011;4299.849505267301;4303.526612072669;4303.806328715215;4305.655547556188;4867.148249056401;4873.293372460973;4879.951200488021;4884.8290309838985;4887.877803054881;5735.053716136874;5763.279590051244;5772.595918285764;5773.884522309614;5775.047117225611;1464.6850927050734;1514.6440586462172;1517.1276516003343;1517.9392824286904;1518.020876534629;1026.5021464589668;1047.539082803564;1049.4385503755454;1065.3767545985686;1066.898644628759;4977.129002424561;4995.800167993312;4997.600191984632;5001.874953126128;5004.249362595567;5915.970420147872;5917.437843404869;5926.940730592725;5936.257967754031;5939.346671866091;4873.439554451213;4917.237828136645;4984.177610694267;4988.925166122511;5018.0214858103045;3181.3478236961832;3198.8400579970908;3209.903702888917;3217.6460589335156;3219.3722224166063;5649.265595472562;5669.6314739541795;5675.574331925122;5677.403872593401;5680.147977803363;6024.3072046714315;6152.384761523812;6162.383761623802;6168.784092556739;6172.444479996821;5676.886462270814;5677.971610141923;5678.006348888928;5680.857978550569;5690.829275121753;5987.88024239504;6012.6993650316435;6013;6017.398260174123;6017.849553761191;5857.94142058591;5859.853503662443;5863.120531920075;5864.091065884794;5869.765209391748;5526.171074338881;5662.490375866192;5663.093904975349;5670.603057785916;5671.574631902541;4257.169851878978;4263;4263.722858014219;4265.658747300271;4268.551802060739;5992.221011268682;6010.669413182142;6013.729382177725;6018.127371531191;6020.0668896319385;5546.278983732089;5745.770169193353;5755.280589926259;5758.596898217084;5773.393793651606;5723.112917497794;5769.394213607511;5772.826815195551;5781.479666829838;5794.710264486843;5650.26546548946;5660.15097735343;5669.943300566942;5671.943280567141;5673.77304907799;5650.660960342392;5782.10377391505;5832.883342333044;5836.503897168788;5839;5689.146628005667;5693.516051135534;5697.031504644137;5698.943010569841;5703.401142879938 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.0815831261049;749.5502698380972;785.7132146766429;790.6560646118942;797.1629788721842;11797.70505737356;12001.639950801467;12010.819837702442;12014.579489717862;12029;11383.430828458586;11517.654470365902;11526.596569120062;11592.65222043338;11716.355600441972;627.2942939193407;633.3033662970719;748.6069813347981;794.0590400375545;808.0303635637259;783.7296132834163;798.2855344466699;806.6773290683715;807.0879905706544;810.3274282345668;817.8609636361833;846.4751853850621;851.4891065360765;851.7231899632613;852.2031900173326;649.7076315657973;655.1908393134476;815.8939337886067;836.030204962247;849.4393700157866;610.9053096770008;617.85171558826;630.2311180359999;630.8895943209966;631.5389765471186;11607.419629018515;11674.35791031493;11691.94154029233;11693.356865372401;11716.472758725879;10937.234393592451;11367.431628418628;11422.771544569145;11506.424678766029;11703.590374336858;8892.199702026785;9024.548772561346;9078.528827037773;9259.907400925971;9326.673566425143;3303.7357011439026;3327.3844338797157;3329.6337402885665;3333.5666363372607;3335.933281334384;37433.81283093567;37701;37805;37846.24307513862;37910.24179516394;9082.682106126254;9208.12522810332;9247.907520924704;9263.166315031545;9372.06279372071;16220.756688649679;16226.188690565425;16262.430814921421;16281.51155465338;16323.510294691177;6410.8717825643225;6656.733730650816;6669.333066693292;6739;6952.617606031717;3383.5263063171174;3472.3228970350538;3491.965080349215;3500.369933411959;3528.241428092921;2563.179782469629;2597.6752905886765;2604.6353510508543;2606.4787042591556;2609.3607066268505;464.94420669519195;475.12339733192204;476.08353918706354;476.7925952210799;478.4784584802582;572.6850232372178;628.8144997225738;630.1996464490072;633.8352028472539;645.4352441613588;7245.89131163033;7668.501547399401;8083.474574152661;8316.251537361546;8336.583170841433;524.7350088205432;586.9354371019269;623.1587357067922;629.1820633176852;636.2015670333701;3687.870924517629;3754.455603937414;3871.496705428276;3881.378979363288;3929.5088113985753;49805;50530.242046369334;50635;50699.23951140736;50719.74640126776;45806.54193458023;49245.261321080216;49816.25275620868;50446;51729;40797.592024079975;41756.79121604433;41800.16399671989;42176;43116.9220769477;7852.450328476952;8257;8277.420580559303;8277.917220827714;8475.152484751723;30857.537136942516;31852.362952741278;31909;31965.36069278648;32657.18357041093;38394;38913.886889049376;38962.80518597389;39360.6063939357;39581.80209098936;9834.557444914853;9866.55600497965;9928.404295742279;9956.253281003808;10019.749506262402;11310.264832785842;11453.19827612059;11463.828042579535;11837.82243266369;11922.463489142836;10232.795344092927;10270.845937310796;10274.794504110025;10975.670729878117;11775.057995360521;10370.585176593153;10663.306885052447;11041.227114101936;11085.501152447998;11424.428778561205;8298.27614857836;10043.598256069676;10523.73690657709;10582.4708764563;10622.8937710625;8708.521031343336;9181.403208791407;9543;9710;9790.706278811647;9022.368434209542;9052.592633331647;9369.953150234205;9376.765580860532;9485.478298693362 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079364142__endTimestamp 23:49:24 INFO - 2015-12-13 23:49:24,152 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,153 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:49:24 INFO - 2015-12-13 23:49:24,153 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:49:24 INFO - 2015-12-13 23:49:24,154 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,154 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4691.59 Median:4841.88 stddev:494.82 (10.2%) stddev-sans-first:468.47 23:49:24 INFO - 2015-12-13 23:49:24,154 DEBUG : BROWSER_OUTPUT: Values: 2604.5 2718.3 2732.8 2739.8 2745.8 4577.9 4709.3 4746.8 4768.3 4777.7 4644.9 4712.1 4741.8 4751.8 4886.6 4365.0 4366.3 4424.9 4492.6 4533.0 4446.6 4500.2 4518.6 4520.6 4565.6 4215.4 4263.7 4320.0 4327.4 4413.8 4412.6 4415.0 4418.2 4427.8 4453.3 4376.8 4387.2 4396.5 4405.5 4439.3 4494.7 4610.8 4615.2 4625.4 4750.9 5108.5 5112.1 5121.9 5173.0 5189.2 5122.1 5130.3 5131.2 5135.6 5182.5 4581.2 4676.5 4680.2 4722.8 4737.2 4979.7 5071.8 5090.2 5099.4 5127.5 5021.8 5029.4 5034.5 5035.6 5080.0 4872.6 4977.3 4989.5 5120.8 5133.4 5042.9 5132.4 5135.2 5135.7 5160.8 5027.4 5049.1 5053.6 5056.4 5099.2 3965.6 4096.9 4100.1 4214.8 4259.4 3615.7 3671.3 3681.5 3688.1 3712.4 4395.2 4404.4 4407.1 4410.4 4452.2 4870.5 4992.0 4994.1 5146.3 5193.6 4300.6 4357.9 4358.6 4388.4 4405.8 4505.8 4512.4 4534.7 4537.3 4545.5 4710.5 4822.2 4823.8 4841.9 4867.1 5017.6 5077.4 5096.9 5106.2 5130.2 4865.2 4868.2 4871.3 4872.8 4918.2 4898.0 5077.3 5080.4 5081.9 5118.4 5016.9 5021.8 5056.0 5128.1 5174.4 4956.1 4958.7 4987.8 4993.8 5033.1 4709.6 4944.9 4958.9 4962.1 4963.8 4716.1 4775.9 4792.3 4860.8 4876.9 5020.7 5033.2 5033.8 5035.8 5036.8 4718.8 4927.7 4928.2 4931.5 4971.9 23:49:24 INFO - 2015-12-13 23:49:24,154 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,154 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42820.76 Median:179055.26 stddev:69935.63 (39.1%) stddev-sans-first:70059.81 23:49:24 INFO - 2015-12-13 23:49:24,155 DEBUG : BROWSER_OUTPUT: Values: 554.1 560.5 569.8 587.6 591.0 26700.6 36442.8 37002.8 37051.6 37093.4 40282.2 40867.4 40871.0 40880.6 40936.6 7004.0 7132.5 7891.7 8065.8 8066.0 10188.9 10395.5 10475.7 10486.4 10503.6 10067.3 10177.4 10183.7 10187.9 10197.3 7040.4 7287.7 10117.9 10231.5 10241.9 10172.2 10429.8 10459.3 10463.7 10463.9 37199.3 37707.8 37708.8 37782.6 37829.0 2956.6 2967.0 3041.9 3228.0 3447.0 28038.6 28206.2 28294.7 28449.1 28538.4 3376.8 3472.4 3497.8 3500.4 3603.1 217534.0 218807.0 219486.0 219853.0 220041.0 50503.0 51578.7 56022.4 56076.7 59726.0 54950.0 54955.0 55244.4 55275.4 55372.7 12846.2 12981.3 12996.4 13003.9 13004.3 8843.2 9315.4 9489.2 9631.2 9902.7 19106.2 19379.8 19467.6 19498.2 19510.9 7797.4 7972.4 8038.5 8096.7 8116.4 833.4 875.3 877.7 983.3 1059.0 26339.1 26578.5 26715.5 26724.2 26728.0 975.4 989.2 1039.8 1109.5 1137.9 13913.6 14250.8 14330.9 15144.2 16023.8 318409.0 323938.0 325710.0 326115.0 326427.0 49183.3 49400.5 49762.8 49857.3 49891.5 1203.2 1228.4 1248.3 1252.8 1253.9 26663.6 27422.5 27721.7 28126.0 28213.0 38866.0 39376.8 39382.4 39385.6 39420.0 246798.0 249219.0 249352.0 249541.0 249579.0 25803.7 26393.9 28714.4 28727.3 29101.4 32835.7 45087.5 46656.5 46866.5 47745.3 33075.8 33171.2 33788.7 34439.3 34629.7 27741.0 32400.5 35883.8 37827.2 39511.8 33129.0 38219.8 39054.4 39119.4 40011.2 29235.9 30145.0 30662.7 30699.8 30859.8 23621.0 23698.9 23994.8 24000.4 24113.3 23:49:24 INFO - 2015-12-13 23:49:24,155 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,155 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27310.49 Median:4048.51 stddev:87350.60 (2157.6%) stddev-sans-first:87572.14 23:49:24 INFO - 2015-12-13 23:49:24,155 DEBUG : BROWSER_OUTPUT: Values: 328.1 334.1 334.6 335.2 335.5 12670.5 12951.2 15068.6 15405.4 15945.0 10000.7 10271.7 10647.6 15109.8 15135.2 4561.3 4660.4 4685.0 4690.3 4694.0 5008.2 5080.5 5086.3 5087.1 5087.5 5015.7 5027.9 5052.0 5053.3 5054.2 4901.5 5005.3 5014.4 5014.5 5019.5 4510.0 4510.0 4511.9 4515.1 4516.7 11966.6 12047.9 12056.1 12067.4 14719.9 1779.9 1791.8 1805.1 1848.0 1958.4 9267.8 9889.1 10366.8 12926.4 13036.7 1704.5 1729.9 1749.7 1764.5 1787.6 54849.0 56836.4 56843.0 56990.7 58659.7 9812.9 9842.0 9898.4 9969.2 10085.2 10585.5 10842.2 12321.3 12339.8 12353.7 6417.3 6638.9 6664.4 6698.2 6727.8 6494.0 6494.9 6552.2 6584.0 6629.8 3934.5 4034.0 4044.5 4052.5 4072.4 1721.9 1740.5 1741.7 1775.0 1779.5 808.2 843.0 847.3 863.0 956.6 15630.3 15822.3 15835.8 16130.4 16223.0 826.6 838.8 840.6 923.4 980.6 8963.3 9346.7 9762.6 9809.6 9868.8 525216.0 525371.0 532217.0 544100.0 545182.0 73496.6 74424.0 74866.0 75901.2 77030.2 1044.7 1050.7 1154.6 1179.8 1180.4 14641.6 14836.1 14948.6 15008.6 15151.5 22712.1 30976.4 32185.8 34848.7 35172.0 40827.6 41944.4 43124.6 43297.8 43558.3 8829.4 8875.7 8933.2 9008.7 9111.1 10636.5 10708.2 10751.3 10787.2 10846.4 11345.7 13902.7 14033.6 14198.7 14496.6 13254.5 13341.8 13635.6 13670.1 14136.9 9902.8 11270.8 13406.5 13605.6 13666.7 8702.7 8706.9 8848.1 8848.7 8889.0 10327.4 12726.6 12904.5 13631.2 13651.2 23:49:24 INFO - 2015-12-13 23:49:24,155 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,156 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5073.50 Median:6423.15 stddev:2663.08 (41.5%) stddev-sans-first:2655.13 23:49:24 INFO - 2015-12-13 23:49:24,156 DEBUG : BROWSER_OUTPUT: Values: 1259.9 1409.3 1421.6 1551.4 1728.1 6346.0 7215.1 7409.4 7410.6 7433.3 7009.8 7015.6 7053.0 7071.9 7075.6 1771.8 1813.1 2122.7 2169.8 2173.6 2096.7 2145.4 2146.2 2146.8 2149.3 2018.3 2030.9 2074.4 2084.2 2087.9 2109.0 2134.8 2136.4 2163.2 2164.7 2115.1 2141.8 2144.2 2144.3 2146.2 7271.0 7364.2 7399.4 7399.4 7405.7 4172.7 4226.7 4235.7 4244.7 4257.3 2662.6 2713.6 2719.5 2729.9 2740.1 885.2 889.4 891.0 900.7 924.4 9667.4 9687.0 9698.3 9700.2 9709.4 3915.9 3971.8 4020.3 4020.4 4024.3 8348.8 8352.2 8353.4 8371.7 8388.3 4306.0 4308.6 4319.4 4341.5 4345.9 3954.0 3954.1 3955.3 3956.9 3979.4 3028.4 3062.5 3147.5 3429.1 3515.5 1069.9 1070.7 1072.4 1083.9 1086.6 829.9 834.8 835.0 915.2 959.1 6887.2 6930.6 6934.8 6972.7 6975.5 1008.6 1030.3 1036.1 1048.2 1050.9 5304.2 5376.8 5387.6 5393.0 5410.3 8697.7 8873.6 9069.8 9100.5 9106.9 8900.7 8964.2 8982.1 9001.9 9002.5 6684.3 6717.4 6784.8 6847.3 7018.0 6583.4 6618.8 6622.1 6630.7 6636.8 7857.5 8032.3 8067.9 8068.3 8085.6 8053.5 8177.6 8221.8 8278.3 8327.3 5866.5 6503.2 6555.3 6555.4 6558.1 5925.3 6090.7 6416.3 6423.1 6471.7 6538.3 6566.7 6668.5 6671.6 6707.2 6423.2 6429.6 6477.5 6511.0 6535.2 6664.2 6703.5 6726.8 6731.0 6744.9 6131.4 6156.2 6164.7 6173.0 6177.6 6012.7 6169.8 6172.9 6175.1 6204.6 23:49:24 INFO - 2015-12-13 23:49:24,156 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,156 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4788.29 Median:5209.18 stddev:1393.39 (26.7%) stddev-sans-first:1356.04 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: Values: 304.0 309.3 309.7 310.1 316.1 5471.8 5487.8 5489.7 5493.8 5549.3 5146.7 5262.8 5300.0 5429.5 5466.0 4264.9 4272.0 4276.9 4278.4 4288.8 4035.0 4276.1 4279.7 4280.0 4283.2 4090.2 4114.5 4190.7 4200.5 4208.9 4173.3 4189.9 4195.4 4200.1 4207.2 3718.1 3752.5 3757.9 3759.2 3764.3 5085.3 5133.5 5149.6 5151.3 5155.5 4760.8 4900.5 4917.1 4926.0 4928.8 5762.8 5776.9 5782.0 5785.0 5785.9 4077.8 4079.2 4085.1 4085.2 4085.2 5932.8 5970.7 6072.3 6078.3 6083.6 4226.5 4231.0 4231.8 4237.1 4242.2 4294.9 4299.8 4303.5 4303.8 4305.7 4867.1 4873.3 4880.0 4884.8 4887.9 5735.1 5763.3 5772.6 5773.9 5775.0 1464.7 1514.6 1517.1 1517.9 1518.0 1026.5 1047.5 1049.4 1065.4 1066.9 4977.1 4995.8 4997.6 5001.9 5004.2 5916.0 5917.4 5926.9 5936.3 5939.3 4873.4 4917.2 4984.2 4988.9 5018.0 3181.3 3198.8 3209.9 3217.6 3219.4 5649.3 5669.6 5675.6 5677.4 5680.1 6024.3 6152.4 6162.4 6168.8 6172.4 5676.9 5678.0 5678.0 5680.9 5690.8 5987.9 6012.7 6013.0 6017.4 6017.8 5857.9 5859.9 5863.1 5864.1 5869.8 5526.2 5662.5 5663.1 5670.6 5671.6 4257.2 4263.0 4263.7 4265.7 4268.6 5992.2 6010.7 6013.7 6018.1 6020.1 5546.3 5745.8 5755.3 5758.6 5773.4 5723.1 5769.4 5772.8 5781.5 5794.7 5650.3 5660.2 5669.9 5671.9 5673.8 5650.7 5782.1 5832.9 5836.5 5839.0 5689.1 5693.5 5697.0 5698.9 5703.4 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12381.30 Median:24861.87 stddev:14121.58 (56.8%) stddev-sans-first:14133.95 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: Values: 701.1 749.6 785.7 790.7 797.2 11797.7 12001.6 12010.8 12014.6 12029.0 11383.4 11517.7 11526.6 11592.7 11716.4 627.3 633.3 748.6 794.1 808.0 783.7 798.3 806.7 807.1 810.3 817.9 846.5 851.5 851.7 852.2 649.7 655.2 815.9 836.0 849.4 610.9 617.9 630.2 630.9 631.5 11607.4 11674.4 11691.9 11693.4 11716.5 10937.2 11367.4 11422.8 11506.4 11703.6 8892.2 9024.5 9078.5 9259.9 9326.7 3303.7 3327.4 3329.6 3333.6 3335.9 37433.8 37701.0 37805.0 37846.2 37910.2 9082.7 9208.1 9247.9 9263.2 9372.1 16220.8 16226.2 16262.4 16281.5 16323.5 6410.9 6656.7 6669.3 6739.0 6952.6 3383.5 3472.3 3492.0 3500.4 3528.2 2563.2 2597.7 2604.6 2606.5 2609.4 464.9 475.1 476.1 476.8 478.5 572.7 628.8 630.2 633.8 645.4 7245.9 7668.5 8083.5 8316.3 8336.6 524.7 586.9 623.2 629.2 636.2 3687.9 3754.5 3871.5 3881.4 3929.5 49805.0 50530.2 50635.0 50699.2 50719.7 45806.5 49245.3 49816.3 50446.0 51729.0 40797.6 41756.8 41800.2 42176.0 43116.9 7852.5 8257.0 8277.4 8277.9 8475.2 30857.5 31852.4 31909.0 31965.4 32657.2 38394.0 38913.9 38962.8 39360.6 39581.8 9834.6 9866.6 9928.4 9956.3 10019.7 11310.3 11453.2 11463.8 11837.8 11922.5 10232.8 10270.8 10274.8 10975.7 11775.1 10370.6 10663.3 11041.2 11085.5 11424.4 8298.3 10043.6 10523.7 10582.5 10622.9 8708.5 9181.4 9543.0 9710.0 9790.7 9022.4 9052.6 9370.0 9376.8 9485.5 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:49:24 INFO - 2015-12-13 23:49:24,157 DEBUG : BROWSER_OUTPUT: 23:49:25 INFO - 2015-12-13 23:49:25,609 INFO : Browser exited with error code: 0 23:49:25 INFO - 2015-12-13 23:49:25,630 INFO : Completed test dromaeo_css (00:19:38) 23:49:25 INFO - 2015-12-13 23:49:25,631 INFO : Starting test kraken 23:49:25 INFO - 2015-12-13 23:49:25,631 DEBUG : operating with platform_type : linux_ 23:49:25 INFO - 2015-12-13 23:49:25,631 INFO : Initialising browser for kraken test... 23:49:25 INFO - 2015-12-13 23:49:25,637 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK02ws0/profile http://localhost:41840/getInfo.html 23:49:37 INFO - 2015-12-13 23:49:37,558 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:49:37 INFO - 2015-12-13 23:49:37,558 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:49:37 INFO - 2015-12-13 23:49:37,559 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:49:37 INFO - 2015-12-13 23:49:37,559 DEBUG : BROWSER_OUTPUT: __metrics 23:49:37 INFO - 2015-12-13 23:49:37,997 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] 23:49:38 INFO - 2015-12-13 23:49:38,058 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] 23:49:42 INFO - 2015-12-13 23:49:42,845 INFO : Browser initialized. 23:49:42 INFO - 2015-12-13 23:49:42,846 INFO : Running cycle 1/1 for kraken test... 23:49:42 INFO - 2015-12-13 23:49:42,846 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK02ws0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:49:54 INFO - 2015-12-13 23:49:54,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 143069184 23:49:54 INFO - 2015-12-13 23:49:54,805 DEBUG : BROWSER_OUTPUT: 23:49:57 INFO - 2015-12-13 23:49:57,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41840/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:58 INFO - 2015-12-13 23:49:58,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 180133888 23:49:58 INFO - 2015-12-13 23:49:58,013 DEBUG : BROWSER_OUTPUT: 23:50:00 INFO - 2015-12-13 23:50:00,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41840/tests/kraken/driver.html?testName=audio-dft) 23:50:01 INFO - 2015-12-13 23:50:01,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 168935424 23:50:01 INFO - 2015-12-13 23:50:01,331 DEBUG : BROWSER_OUTPUT: 23:50:04 INFO - 2015-12-13 23:50:04,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41840/tests/kraken/driver.html?testName=audio-fft) 23:50:04 INFO - 2015-12-13 23:50:04,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 154734592 23:50:04 INFO - 2015-12-13 23:50:04,874 DEBUG : BROWSER_OUTPUT: 23:50:06 INFO - 2015-12-13 23:50:06,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41840/tests/kraken/driver.html?testName=audio-oscillator) 23:50:07 INFO - 2015-12-13 23:50:07,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 154718208 23:50:07 INFO - 2015-12-13 23:50:07,517 DEBUG : BROWSER_OUTPUT: 23:50:09 INFO - 2015-12-13 23:50:09,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:50:10 INFO - 2015-12-13 23:50:10,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 157622272 23:50:10 INFO - 2015-12-13 23:50:10,336 DEBUG : BROWSER_OUTPUT: 23:50:13 INFO - 2015-12-13 23:50:13,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41840/tests/kraken/driver.html?testName=imaging-darkroom) 23:50:13 INFO - 2015-12-13 23:50:13,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 157450240 23:50:13 INFO - 2015-12-13 23:50:13,921 DEBUG : BROWSER_OUTPUT: 23:50:17 INFO - 2015-12-13 23:50:17,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41840/tests/kraken/driver.html?testName=imaging-desaturate) 23:50:18 INFO - 2015-12-13 23:50:18,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 155521024 23:50:18 INFO - 2015-12-13 23:50:18,133 DEBUG : BROWSER_OUTPUT: 23:50:20 INFO - 2015-12-13 23:50:20,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41840/tests/kraken/driver.html?testName=json-parse-financial) 23:50:21 INFO - 2015-12-13 23:50:21,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 155099136 23:50:21 INFO - 2015-12-13 23:50:21,516 DEBUG : BROWSER_OUTPUT: 23:50:23 INFO - 2015-12-13 23:50:23,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:50:23 INFO - 2015-12-13 23:50:23,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 170070016 23:50:23 INFO - 2015-12-13 23:50:23,856 DEBUG : BROWSER_OUTPUT: 23:50:25 INFO - 2015-12-13 23:50:25,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:50:26 INFO - 2015-12-13 23:50:26,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 169750528 23:50:26 INFO - 2015-12-13 23:50:26,320 DEBUG : BROWSER_OUTPUT: 23:50:28 INFO - 2015-12-13 23:50:28,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:50:29 INFO - 2015-12-13 23:50:29,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 182108160 23:50:29 INFO - 2015-12-13 23:50:29,059 DEBUG : BROWSER_OUTPUT: 23:50:31 INFO - 2015-12-13 23:50:31,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:50:32 INFO - 2015-12-13 23:50:32,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 187437056 23:50:32 INFO - 2015-12-13 23:50:32,214 DEBUG : BROWSER_OUTPUT: 23:50:34 INFO - 2015-12-13 23:50:34,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:50:35 INFO - 2015-12-13 23:50:35,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 184897536 23:50:35 INFO - 2015-12-13 23:50:35,381 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41840/tests/kraken/driver.html?testName=ai-astar) 23:50:37 INFO - 2015-12-13 23:50:37,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 243048448 23:50:37 INFO - 2015-12-13 23:50:37,397 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,398 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:50:37 INFO - 2015-12-13 23:50:37,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:50:37 INFO - 2015-12-13 23:50:37,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:50:37 INFO - 2015-12-13 23:50:37,399 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:50:37 INFO - 2015-12-13 23:50:37,399 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;106;111;113;113;101;111;112;111 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;154;164;130;153;152;131;171;132 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;158;160;160;159;159;163;160 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;72;89;93;73;74;74;112;89;74 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;94;95;127;95;93;138 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;110 23:50:37 INFO - 2015-12-13 23:50:37,400 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;72;71;71;72;72;81;70;69 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;68;67;69;68;67;68 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;84;85;85;85;83;83;86;92 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;126;127;122;122;128;133;128;122 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;136;151;150;150;140;147;145;151;136 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;71;70;73;71;70;77;70;69 23:50:37 INFO - 2015-12-13 23:50:37,401 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:50:37 INFO - 2015-12-13 23:50:37,402 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:50:37 INFO - 2015-12-13 23:50:37,402 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,999 23:50:37 INFO - 2015-12-13 23:50:37,402 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:50:37 INFO - 2015-12-13 23:50:37,402 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079437397__endTimestamp 23:50:37 INFO - 2015-12-13 23:50:37,402 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.82 (3.4%) stddev-sans-first:4.04 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 106.0 111.0 113.0 113.0 101.0 111.0 112.0 111.0 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.00 stddev:14.93 (9.8%) stddev-sans-first:15.69 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 154.0 164.0 130.0 153.0 152.0 131.0 171.0 132.0 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 158.0 160.0 160.0 159.0 159.0 163.0 160.0 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,410 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.30 Median:78.50 stddev:12.81 (16.3%) stddev-sans-first:13.58 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: Values: 83.0 72.0 89.0 93.0 73.0 74.0 74.0 112.0 89.0 74.0 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.73 (19.9%) stddev-sans-first:19.46 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 94.0 95.0 127.0 95.0 93.0 138.0 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,411 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 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 23:50:37 INFO - 2015-12-13 23:50:37,411 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:3.27 (4.5%) stddev-sans-first:3.46 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 71.0 71.0 72.0 72.0 81.0 70.0 69.0 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 68.0 67.0 69.0 68.0 67.0 68.0 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.64 (3.1%) stddev-sans-first:2.80 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 84.0 85.0 85.0 85.0 83.0 83.0 86.0 92.0 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:3.45 (2.7%) stddev-sans-first:3.64 23:50:37 INFO - 2015-12-13 23:50:37,412 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 126.0 127.0 122.0 122.0 128.0 133.0 128.0 122.0 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:148.50 stddev:5.90 (4.0%) stddev-sans-first:6.25 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: Values: 146.0 136.0 151.0 150.0 150.0 140.0 147.0 145.0 151.0 136.0 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:2.31 (3.3%) stddev-sans-first:2.40 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 71.0 70.0 73.0 71.0 70.0 77.0 70.0 69.0 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:50:37 INFO - 2015-12-13 23:50:37,413 DEBUG : BROWSER_OUTPUT: 23:50:38 INFO - 2015-12-13 23:50:38,733 INFO : Browser exited with error code: 0 23:50:38 INFO - 2015-12-13 23:50:38,789 INFO : Completed test kraken (00:01:13) 23:50:38 INFO - 2015-12-13 23:50:38,789 INFO : Starting test v8_7 23:50:38 INFO - 2015-12-13 23:50:38,789 DEBUG : operating with platform_type : linux_ 23:50:38 INFO - 2015-12-13 23:50:38,789 INFO : Initialising browser for v8_7 test... 23:50:38 INFO - 2015-12-13 23:50:38,795 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRlhoK/profile http://localhost:41840/getInfo.html 23:50:53 INFO - 2015-12-13 23:50:53,319 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:50:53 INFO - 2015-12-13 23:50:53,319 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:50:53 INFO - 2015-12-13 23:50:53,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:50:53 INFO - 2015-12-13 23:50:53,319 DEBUG : BROWSER_OUTPUT: __metrics 23:50:54 INFO - 2015-12-13 23:50:54,679 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] 23:50:54 INFO - 2015-12-13 23:50:54,759 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] 23:51:00 INFO - 2015-12-13 23:51:00,269 INFO : Browser initialized. 23:51:00 INFO - 2015-12-13 23:51:00,270 INFO : Running cycle 1/1 for v8_7 test... 23:51:00 INFO - 2015-12-13 23:51:00,270 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRlhoK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:51:12 INFO - 2015-12-13 23:51:12,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 142376960 23:51:12 INFO - 2015-12-13 23:51:12,268 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41840/tests/v8_7/run.html (next: http://localhost:41840/tests/v8_7/run.html) 23:51:34 INFO - 2015-12-13 23:51:34,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 443121664 23:51:34 INFO - 2015-12-13 23:51:34,439 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,439 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:51:34 INFO - 2015-12-13 23:51:34,439 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:51:34 INFO - 2015-12-13 23:51:34,439 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.08236165093467 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2057.61316872428 23:51:34 INFO - 2015-12-13 23:51:34,440 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: |8;Splay;615.7635467980296 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079494433__endTimestamp 23:51:34 INFO - 2015-12-13 23:51:34,441 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: Values: 165.8 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.08 Median:185.08 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,442 DEBUG : BROWSER_OUTPUT: Values: 185.1 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: Values: 277.7 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: Values: 5181.3 23:51:34 INFO - 2015-12-13 23:51:34,443 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2057.61 Median:2057.61 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: Values: 2057.6 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: Values: 783.7 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,444 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: Values: 12444.4 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: Values: 27432.4 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: Values: 615.8 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: Values: 4822.1 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:51:34 INFO - 2015-12-13 23:51:34,445 DEBUG : BROWSER_OUTPUT: 23:51:36 INFO - 2015-12-13 23:51:36,141 INFO : Browser exited with error code: 0 23:51:36 INFO - 2015-12-13 23:51:36,153 INFO : Completed test v8_7 (00:00:57) 23:51:36 INFO - 2015-12-13 23:51:36,251 INFO : Completed test suite (00:21:49) 23:51:36 INFO - 2015-12-13 23:51:36,251 DEBUG : Working with test: dromaeo_css 23:51:36 INFO - 2015-12-13 23:51:36,251 DEBUG : Generating results file: dromaeo_css 23:51:36 INFO - 2015-12-13 23:51:36,252 DEBUG : Working with test: kraken 23:51:36 INFO - 2015-12-13 23:51:36,252 DEBUG : Generating results file: kraken 23:51:36 INFO - 2015-12-13 23:51:36,252 INFO : javascript benchmark 23:51:36 INFO - 2015-12-13 23:51:36,253 DEBUG : Working with test: v8_7 23:51:36 INFO - 2015-12-13 23:51:36,253 DEBUG : Generating results file: v8_7 23:51:36 INFO - 2015-12-13 23:51:36,253 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:51:36 INFO - 2015-12-13 23:51:36,308 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 23:51:36 INFO - 2015-12-13 23:51:36,308 DEBUG : process_Request line: dromaeo_css 6390.74 graph.html#tests=[[72,203,35]] 23:51:36 INFO - 2015-12-13 23:51:36,308 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:51:36 INFO - 2015-12-13 23:51:36,343 DEBUG : process_Request line: kraken 1524.50 graph.html#tests=[[232,203,35]] 23:51:36 INFO - 2015-12-13 23:51:36,343 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:51:36 INFO - 2015-12-13 23:51:36,369 DEBUG : process_Request line: v8_7 19661.93 graph.html#tests=[[230,203,35]] 23:51:36 INFO - 2015-12-13 23:51:36,370 INFO : javascript benchmark 23:51:36 INFO - 2015-12-13 23:51:36,374 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.479104179164, 2718.320419895026, 2732.7540521353085, 2739.835609863409, 2745.8489783061923, 4577.931331030038, 4709.340692303072, 4746.810127594897, 4768.30859525369, 4777.665563410558, 4644.930326045103, 4712.104700106977, 4741.8103275868925, 4751.833685820997, 4886.584640305569, 4364.956350436495, 4366.279563871974, 4424.933625995613, 4492.618127459154, 4533.0253995390985, 4446.622037126832, 4500.234960056799, 4518.615917646987, 4520.570545798144, 4565.61192298655, 4215.43091682622, 4263.701540892139, 4320.0, 4327.437433133672, 4413.801378937924, 4412.580804823537, 4415.0, 4418.226810308183, 4427.845025424094, 4453.332000199964, 4376.759278239696, 4387.232234358974, 4396.538363471821, 4405.471343438776, 4439.2675208590545, 4494.73031618104, 4610.838620648261, 4615.215413379734, 4625.352450656911, 4750.904981900343, 5108.489151084899, 5112.054269960032, 5121.871953201163, 5172.9741351293005, 5189.2475591039465, 5122.052420302256, 5130.333056702605, 5131.230315452674, 5135.6148288878485, 5182.455842136559, 4581.152486789954, 4676.485586585541, 4680.227762419231, 4722.834700785456, 4737.1946769049, 4979.701217926936, 5071.822486212965, 5090.185570308733, 5099.4390617032095, 5127.4872512748425, 5021.84934451967, 5029.371328583927, 5034.471380505068, 5035.571976381975, 5079.974600126976, 4872.610191184696, 4977.253411988158, 4989.451160372356, 5120.795168193231, 5133.409657889316, 5042.949570504248, 5132.435432102466, 5135.229715542624, 5135.666181698252, 5160.819371322061, 5027.4469808321055, 5049.091163590589, 5053.570446512088, 5056.394808396857, 5099.158638824627, 3965.5637879833193, 4096.938545921814, 4100.138970816162, 4214.768187749642, 4259.403683484315, 3615.6565126312958, 3671.2657468506404, 3681.5398075240596, 3688.133288677159, 3712.406015037581, 4395.1868904252815, 4404.4494438195225, 4407.140607581491, 4410.360497727812, 4452.1763473757455, 4870.488598697157, 4991.950080499221, 4994.051130285234, 5146.305248791366, 5193.584513238932, 4300.634446072057, 4357.9128417431475, 4358.564143585616, 4388.363687265329, 4405.7797110144365, 4505.7521836298665, 4512.435945506812, 4534.7052441591195, 4537.251353526697, 4545.499995000548, 4710.528947105262, 4822.156122678447, 4823.831165909176, 4841.878953026203, 4867.123917694849, 5017.573506251863, 5077.365329333833, 5096.923546146885, 5106.183010718267, 5130.230465430215, 4865.197242455097, 4868.245421959602, 4871.318015477907, 4872.805087796449, 4918.213085906238, 4897.975510122426, 5077.289179514797, 5080.441151473409, 5081.8729531762, 5118.38579370478, 5016.949830501649, 5021.799128034838, 5055.974720126376, 5128.128218202989, 5174.430812610534, 4956.083124621957, 4958.652894297365, 4987.80048798044, 4993.825216117419, 5033.144365457808, 4709.576138147583, 4944.8763780905765, 4958.925616115834, 4962.057209130398, 4963.8262660806695, 4716.056788642217, 4775.877668747911, 4792.257200133985, 4860.756962151808, 4876.853694389174, 5020.723860187724, 5033.245013248042, 5033.773480193473, 5035.798568057383, 5036.84889453317, 4718.787654555485, 4927.704337739747, 4928.186849169847, 4931.5315045070665, 4971.850844474671], "unit": "ms", "name": "dojo.html", "value": 4660.388684886857}, {"lowerIsBetter": false, "replicates": [554.1419281877297, 560.5263552298306, 569.7920259105426, 587.6092398554961, 590.9704514774262, 26700.59949100765, 36442.817785911066, 37002.8149859251, 37051.629483705154, 37093.44359834598, 40282.19435611293, 40867.38698919518, 40871.0, 40880.59119408805, 40936.59063409365, 7004.0, 7132.536385134949, 7891.684332626703, 8065.838683226332, 8066.0, 10188.898111018907, 10395.532201050972, 10475.68572942809, 10486.423246721428, 10503.579856805718, 10067.29528932975, 10177.389356638625, 10183.745406364826, 10187.949060254688, 10197.286189966706, 7040.3663670269925, 7287.672054757549, 10117.949410252939, 10231.488425578691, 10241.948790256001, 10172.186225102048, 10429.791404171874, 10459.320144190604, 10463.68608941733, 10463.895361046369, 37199.25601487955, 37707.811460942794, 37708.81145594282, 37782.62217377819, 37829.0, 2956.6156399667907, 2966.9703302967127, 3041.863116159778, 3228.0, 3446.9655303446893, 28038.579421308696, 28206.153815385573, 28294.717052829415, 28449.146525604265, 28538.429231415255, 3376.8142752148624, 3472.3923313420305, 3497.842597083137, 3500.3874321993803, 3603.063203567065, 217534.0, 218807.0, 219486.0, 219853.0, 220040.9999999984, 50503.0, 51578.74210628998, 56022.43977560172, 56076.71961640166, 59726.0, 54950.0, 54955.0, 55244.44755552473, 55275.44724552703, 55372.72313638406, 12846.164999275017, 12981.286029268293, 12996.415161317575, 13003.869961300266, 13004.349782511026, 8843.248323892542, 9315.441073535609, 9489.1934185595, 9631.229501639851, 9902.7029189123, 19106.2357505701, 19379.80620193808, 19467.61064778725, 19498.220071197276, 19510.90244548768, 7797.401532685786, 7972.441929065026, 8038.517688938682, 8096.7166149184495, 8116.431849770459, 833.4374297349265, 875.2560323724911, 877.7322916510398, 983.2772911909741, 1059.0045357364206, 26339.07813226528, 26578.468430631277, 26715.465690686076, 26724.19827405181, 26728.0, 975.380633297861, 989.1641562879355, 1039.8180318444242, 1109.5229051507768, 1137.9487923043318, 13913.58259252224, 14250.786238206436, 14330.928345358207, 15144.242787860563, 16023.759643605355, 318409.0, 323938.0, 325710.0, 326115.0, 326427.0, 49183.26225106555, 49400.50599494031, 49762.75118624384, 49857.25214121791, 49891.50108498941, 1203.1517779965104, 1228.42264135856, 1248.332142303863, 1252.7807633664072, 1253.8934190593902, 26663.600045998937, 27422.45155096927, 27721.722782772722, 28126.0, 28213.0, 38866.0, 39376.803115984236, 39382.40926386049, 39385.606143938196, 39420.0, 246798.0, 249219.0, 249352.0, 249541.0, 249579.0, 25803.741962580883, 26393.868030659723, 28714.42571148607, 28727.281817954718, 29101.417971640025, 32835.67164328326, 45087.54912450833, 46656.533434665216, 46866.53133468622, 47745.28382074202, 33075.83462082674, 33171.17072073121, 33788.66211337855, 34439.31121377608, 34629.653703462645, 27741.0, 32400.513992289663, 35883.82058089693, 37827.24345513129, 39511.80244098761, 33129.0, 38219.808900955315, 39054.4141837867, 39119.41320880132, 40011.1997760049, 29235.85382073076, 30145.0, 30662.693373065984, 30699.846500768246, 30859.84570077225, 23621.0, 23698.881505592362, 23994.76005239995, 24000.39999000039, 24113.27660170198], "unit": "ms", "name": "ext.html", "value": 17624.093159005373}, {"lowerIsBetter": false, "replicates": [328.1353633176579, 334.096269590757, 334.57676039809644, 335.16878142207327, 335.4833556323262, 12670.493180272779, 12951.222926624409, 15068.623284417881, 15405.383784648615, 15944.999999999985, 10000.749981250472, 10271.743206419844, 10647.627333043345, 15109.84890151098, 15135.167565783877, 4561.338605902142, 4660.37084993525, 4685.039566888797, 4690.319903613974, 4693.953060469403, 5008.248762685608, 5080.491950804909, 5086.3387759591205, 5087.109755792721, 5087.49125087492, 5015.69905805651, 5027.949720502803, 5052.040112378636, 5053.317802096725, 5054.1660625996665, 4901.53435423636, 5005.274235235906, 5014.398272207341, 5014.52362025607, 5019.52314530119, 4509.954900451019, 4510.0, 4511.909761804745, 4515.142122996653, 4516.6612504061995, 11966.64100076999, 12047.93976030123, 12056.095792815486, 12067.396630168456, 14719.89600779935, 1779.9110044497722, 1791.7849858016991, 1805.0974512743628, 1847.990760046191, 1958.3537432647192, 9267.768305792342, 9889.109980101824, 10366.792664146675, 12926.353682315847, 13036.674083147902, 1704.5056933489273, 1729.9221535030829, 1749.6850566897954, 1764.4882983934644, 1787.642471505704, 54849.0, 56836.431635683526, 56843.0, 56990.715046424506, 58659.706701466646, 9812.852807207897, 9841.950790246003, 9898.356606820533, 9969.152622027064, 10085.243606729524, 10585.523651435704, 10842.241043127064, 12321.260724356389, 12339.814902776465, 12353.691157721129, 6417.262014868256, 6638.933610663928, 6664.433523150587, 6698.162729658793, 6727.798166055026, 6493.967530162414, 6494.870102597922, 6552.180977377828, 6584.0, 6629.801105966829, 3934.488516492838, 4033.979830100831, 4044.51465824103, 4052.513698356157, 4072.429859819628, 1721.9483415497555, 1740.4691569071554, 1741.7474466202584, 1774.9556261093576, 1779.4839496545856, 808.1554775259867, 842.9704960326359, 847.3306088190384, 863.0075413274784, 956.6125719083782, 15630.296636651377, 15822.287997040161, 15835.762463563056, 16130.354785808437, 16223.0, 826.557791581501, 838.7567605394489, 840.5587066789984, 923.353652443279, 980.632262901412, 8963.282937364995, 9346.712720343117, 9762.560684769202, 9809.607615695293, 9868.753281168028, 525216.0, 525371.0, 532217.0, 544100.0, 545182.0, 73496.63251683814, 74424.0, 74866.0, 75901.24098758942, 77030.22969770343, 1044.681372181492, 1050.7425680708275, 1154.6132045764764, 1179.7581495793343, 1180.4097951024487, 14641.560753177422, 14836.10983341003, 14948.626284342978, 15008.624784380478, 15151.469698560497, 22712.145591189692, 30976.380472390876, 32185.839070805432, 34848.65151348556, 35172.0, 40827.59172408238, 41944.3708344369, 43124.56875431331, 43297.78351108224, 43558.346624801285, 8829.426087304304, 8875.689350872946, 8933.240674542736, 9008.684696035607, 9111.088891110836, 10636.52135653913, 10708.196885233794, 10751.301165424222, 10787.190960678137, 10846.403447810446, 11345.716357091138, 13902.652433688834, 14033.578992630237, 14198.716025679636, 14496.565103046925, 13254.469821207043, 13341.799873001719, 13635.590932272047, 13670.11144275619, 14136.929315353358, 9902.801943961225, 11270.83093753578, 13406.530771422953, 13605.591832245049, 13666.658333541742, 8702.695405660772, 8706.91293087061, 8848.070952550148, 8848.734537963872, 8889.022207557293, 10327.431991240554, 12726.618201453972, 12904.483820647445, 13631.24033714045, 13651.249181295125], "unit": "ms", "name": "jquery.html", "value": 8024.965496028268}, {"lowerIsBetter": false, "replicates": [1259.8551166615841, 1409.2953523238382, 1421.6161636358183, 1551.3561871823194, 1728.118659483663, 6345.968270158649, 7215.098112735908, 7409.4072474202, 7410.629468526579, 7433.256674332564, 7009.7897063088185, 7015.6141412222305, 7053.0, 7071.85856282874, 7075.646217689121, 1771.8139595342498, 1813.1206364913007, 2122.7134336864556, 2169.7504786949467, 2173.5870184664864, 2096.741954827107, 2145.442185031895, 2146.227358151072, 2146.828253739697, 2149.279991202941, 2018.3440381875876, 2030.8883011434366, 2074.408793493855, 2084.218418093215, 2087.937361879146, 2109.0, 2134.839887008465, 2136.433845031068, 2163.1671806354666, 2164.7402311722535, 2115.1010820401266, 2141.7751136130637, 2144.2495126705685, 2144.2602302205714, 2146.195176808697, 7270.963645181793, 7364.226756190576, 7399.445041621846, 7399.445041621846, 7405.74079907206, 4172.666186705087, 4226.66186705066, 4235.745855248695, 4244.72409293395, 4257.340112282601, 2662.560677488212, 2713.606527053586, 2719.5104881121392, 2729.9181024569293, 2740.082072505713, 885.2298500304776, 889.3774357949461, 891.0376793063541, 900.7477906186213, 924.4222361024359, 9667.419954802734, 9686.999999999929, 9698.272629552812, 9700.175485083706, 9709.417434953926, 3915.9021024474614, 3971.801409929492, 4020.296448121567, 4020.3567429211184, 4024.335984562573, 8348.833023339621, 8352.206540378655, 8353.415260931677, 8371.706990255434, 8388.32893368529, 4306.0, 4308.569143085666, 4319.416878721395, 4341.522432532419, 4345.869623911288, 3954.0, 3954.130091379892, 3955.268275369066, 3956.8812935611977, 3979.3633018716864, 3028.409460155249, 3062.5406189071373, 3147.4806656901355, 3429.0570093224565, 3515.5078289039557, 1069.9358038517714, 1070.7323169207698, 1072.3994563044564, 1083.8970297821695, 1086.559943222996, 829.8713699376606, 834.8038211020405, 835.0480452284401, 915.2266334946959, 959.0840747086515, 6887.173539175331, 6930.584164950119, 6934.826629334206, 6972.721091156297, 6975.476839237078, 1008.566316483919, 1030.3302853145515, 1036.108946306176, 1048.219076787798, 1050.8686414198226, 5304.23088652151, 5376.838694839161, 5387.649802762886, 5392.973035134799, 5410.269613602113, 8697.739067827975, 8873.600687969058, 9069.818603628022, 9100.499472528942, 9106.908930910738, 8900.73297801067, 8964.238039766562, 8982.101789821096, 9001.909980900238, 9002.504862232508, 6684.2981486944145, 6717.395434410829, 6784.76253331131, 6847.281035491302, 7017.999999999898, 6583.407493325623, 6618.768343107968, 6622.072909792537, 6630.701618427086, 6636.83407914806, 7857.528548286892, 8032.317253033324, 8067.919320806717, 8068.314193293636, 8085.555294458862, 8053.516788992679, 8177.6320065596, 8221.83556328882, 8278.337732981467, 8327.333813294801, 5866.50134738535, 6503.219613646393, 6555.2789193189665, 6555.3772391622715, 6558.147440832661, 5925.288965324189, 6090.695465226632, 6416.294207637063, 6423.0686550450855, 6471.676416179266, 6538.346165383614, 6566.671666416755, 6668.533202675961, 6671.5997040177745, 6707.1616047994, 6423.229212494531, 6429.582077165156, 6477.481801455967, 6510.967445162744, 6535.150430444202, 6664.200295964515, 6703.530752847449, 6726.7981960541265, 6731.024001519654, 6744.898826517704, 6131.356207598138, 6156.199694039746, 6164.722587483484, 6173.0, 6177.567570270038, 6012.669303188367, 6169.784057557964, 6172.938270617236, 6175.104609831459, 6204.627722336674], "unit": "ms", "name": "mootools.html", "value": 4135.397492945146}, {"lowerIsBetter": false, "replicates": [303.9726424621784, 309.33338655198054, 309.71196786988105, 310.10689215060637, 316.1274881327535, 5471.808486702967, 5487.835364939053, 5489.725513724317, 5493.807716729915, 5549.278593782813, 5146.665466744659, 5262.81580144695, 5300.0, 5429.4570542945785, 5465.9726701366435, 4264.87205383839, 4271.957280427203, 4276.893077673052, 4278.4010238566625, 4288.807003684826, 4035.0, 4276.059266961263, 4279.700420970534, 4280.0, 4283.207606592775, 4090.1819636072755, 4114.526829414611, 4190.727602705814, 4200.474940632421, 4208.873733787991, 4173.332266837307, 4189.853355132555, 4195.433616461769, 4200.075983283673, 4207.179599978005, 3718.0518967663074, 3752.4934133891848, 3757.910206040245, 3759.172981943995, 3764.3224219640456, 5085.288059671649, 5133.486651334874, 5149.639525233235, 5151.278820965068, 5155.536001759822, 4760.833370832039, 4900.485449027837, 4917.139500587383, 4926.014797040606, 4928.827491037797, 5762.798302059407, 5776.855578610526, 5782.0, 5785.0, 5785.855353616151, 4077.796110194508, 4079.1637714268504, 4085.060436099684, 4085.22380747657, 4085.2238074765996, 5932.822015339547, 5970.701464926779, 6072.301685306158, 6078.300995385543, 6083.634981901056, 4226.492820861455, 4231.0, 4231.7672528010635, 4237.110206856594, 4242.236397448427, 4294.914101718011, 4299.849505267301, 4303.526612072669, 4303.806328715215, 4305.655547556188, 4867.148249056401, 4873.293372460973, 4879.951200488021, 4884.8290309838985, 4887.877803054881, 5735.053716136874, 5763.279590051244, 5772.595918285764, 5773.884522309614, 5775.047117225611, 1464.6850927050734, 1514.6440586462172, 1517.1276516003343, 1517.9392824286904, 1518.020876534629, 1026.5021464589668, 1047.539082803564, 1049.4385503755454, 1065.3767545985686, 1066.898644628759, 4977.129002424561, 4995.800167993312, 4997.600191984632, 5001.874953126128, 5004.249362595567, 5915.970420147872, 5917.437843404869, 5926.940730592725, 5936.257967754031, 5939.346671866091, 4873.439554451213, 4917.237828136645, 4984.177610694267, 4988.925166122511, 5018.0214858103045, 3181.3478236961832, 3198.8400579970908, 3209.903702888917, 3217.6460589335156, 3219.3722224166063, 5649.265595472562, 5669.6314739541795, 5675.574331925122, 5677.403872593401, 5680.147977803363, 6024.3072046714315, 6152.384761523812, 6162.383761623802, 6168.784092556739, 6172.444479996821, 5676.886462270814, 5677.971610141923, 5678.006348888928, 5680.857978550569, 5690.829275121753, 5987.88024239504, 6012.6993650316435, 6013.0, 6017.398260174123, 6017.849553761191, 5857.94142058591, 5859.853503662443, 5863.120531920075, 5864.091065884794, 5869.765209391748, 5526.171074338881, 5662.490375866192, 5663.093904975349, 5670.603057785916, 5671.574631902541, 4257.169851878978, 4263.0, 4263.722858014219, 4265.658747300271, 4268.551802060739, 5992.221011268682, 6010.669413182142, 6013.729382177725, 6018.127371531191, 6020.0668896319385, 5546.278983732089, 5745.770169193353, 5755.280589926259, 5758.596898217084, 5773.393793651606, 5723.112917497794, 5769.394213607511, 5772.826815195551, 5781.479666829838, 5794.710264486843, 5650.26546548946, 5660.15097735343, 5669.943300566942, 5671.943280567141, 5673.77304907799, 5650.660960342392, 5782.10377391505, 5832.883342333044, 5836.503897168788, 5839.0, 5689.146628005667, 5693.516051135534, 5697.031504644137, 5698.943010569841, 5703.401142879938], "unit": "ms", "name": "prototype.html", "value": 4342.39020198611}, {"lowerIsBetter": false, "replicates": [701.0815831261049, 749.5502698380972, 785.7132146766429, 790.6560646118942, 797.1629788721842, 11797.70505737356, 12001.639950801467, 12010.819837702442, 12014.579489717862, 12029.0, 11383.430828458586, 11517.654470365902, 11526.596569120062, 11592.65222043338, 11716.355600441972, 627.2942939193407, 633.3033662970719, 748.6069813347981, 794.0590400375545, 808.0303635637259, 783.7296132834163, 798.2855344466699, 806.6773290683715, 807.0879905706544, 810.3274282345668, 817.8609636361833, 846.4751853850621, 851.4891065360765, 851.7231899632613, 852.2031900173326, 649.7076315657973, 655.1908393134476, 815.8939337886067, 836.030204962247, 849.4393700157866, 610.9053096770008, 617.85171558826, 630.2311180359999, 630.8895943209966, 631.5389765471186, 11607.419629018515, 11674.35791031493, 11691.94154029233, 11693.356865372401, 11716.472758725879, 10937.234393592451, 11367.431628418628, 11422.771544569145, 11506.424678766029, 11703.590374336858, 8892.199702026785, 9024.548772561346, 9078.528827037773, 9259.907400925971, 9326.673566425143, 3303.7357011439026, 3327.3844338797157, 3329.6337402885665, 3333.5666363372607, 3335.933281334384, 37433.81283093567, 37701.0, 37805.0, 37846.24307513862, 37910.24179516394, 9082.682106126254, 9208.12522810332, 9247.907520924704, 9263.166315031545, 9372.06279372071, 16220.756688649679, 16226.188690565425, 16262.430814921421, 16281.51155465338, 16323.510294691177, 6410.8717825643225, 6656.733730650816, 6669.333066693292, 6739.0, 6952.617606031717, 3383.5263063171174, 3472.3228970350538, 3491.965080349215, 3500.369933411959, 3528.241428092921, 2563.179782469629, 2597.6752905886765, 2604.6353510508543, 2606.4787042591556, 2609.3607066268505, 464.94420669519195, 475.12339733192204, 476.08353918706354, 476.7925952210799, 478.4784584802582, 572.6850232372178, 628.8144997225738, 630.1996464490072, 633.8352028472539, 645.4352441613588, 7245.89131163033, 7668.501547399401, 8083.474574152661, 8316.251537361546, 8336.583170841433, 524.7350088205432, 586.9354371019269, 623.1587357067922, 629.1820633176852, 636.2015670333701, 3687.870924517629, 3754.455603937414, 3871.496705428276, 3881.378979363288, 3929.5088113985753, 49805.0, 50530.242046369334, 50635.0, 50699.23951140736, 50719.74640126776, 45806.54193458023, 49245.261321080216, 49816.25275620868, 50446.0, 51729.0, 40797.592024079975, 41756.79121604433, 41800.16399671989, 42176.0, 43116.9220769477, 7852.450328476952, 8257.0, 8277.420580559303, 8277.917220827714, 8475.152484751723, 30857.537136942516, 31852.362952741278, 31909.0, 31965.36069278648, 32657.18357041093, 38394.0, 38913.886889049376, 38962.80518597389, 39360.6063939357, 39581.80209098936, 9834.557444914853, 9866.55600497965, 9928.404295742279, 9956.253281003808, 10019.749506262402, 11310.264832785842, 11453.19827612059, 11463.828042579535, 11837.82243266369, 11922.463489142836, 10232.795344092927, 10270.845937310796, 10274.794504110025, 10975.670729878117, 11775.057995360521, 10370.585176593153, 10663.306885052447, 11041.227114101936, 11085.501152447998, 11424.428778561205, 8298.27614857836, 10043.598256069676, 10523.73690657709, 10582.4708764563, 10622.8937710625, 8708.521031343336, 9181.403208791407, 9543.0, 9710.0, 9790.706278811647, 9022.368434209542, 9052.592633331647, 9369.953150234205, 9376.765580860532, 9485.478298693362], "unit": "ms", "name": "yui.html", "value": 5754.969341604259}], "name": "dromaeo_css", "value": 6390.737568756647}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 111.0, 113.0, 113.0, 101.0, 111.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 154.0, 164.0, 130.0, 153.0, 152.0, 131.0, 171.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 158.0, 160.0, 160.0, 159.0, 159.0, 163.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [83.0, 72.0, 89.0, 93.0, 73.0, 74.0, 74.0, 112.0, 89.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 94.0, 95.0, 127.0, 95.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 71.0, 71.0, 72.0, 72.0, 81.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 85.0, 85.0, 85.0, 83.0, 83.0, 86.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 126.0, 127.0, 122.0, 122.0, 128.0, 133.0, 128.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [146.0, 136.0, 151.0, 150.0, 150.0, 140.0, 147.0, 145.0, 151.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 70.0, 73.0, 71.0, 70.0, 77.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1524.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [185.08236165093467], "unit": "score", "name": "DeltaBlue", "value": 357.23555399999987}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2057.61316872428], "unit": "score", "name": "RayTrace", "value": 359.63465400000007}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [27432.432432432433], "unit": "score", "name": "RegExp", "value": 33.208320197044344}, {"lowerIsBetter": false, "replicates": [615.7635467980296], "unit": "score", "name": "Splay", "value": 132.34138400000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19661.931309265994}]} 23:51:36 INFO - RETURN: dromaeo_css: 6390.74 23:51:36 INFO - RETURN: kraken: 1524.50 23:51:36 INFO - RETURN: v8_7: 19661.93 23:51:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19661.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1524.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6390.74"}}} 23:51:36 INFO - Return code: 0 23:51:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:51:36 INFO - # TBPL SUCCESS # 23:51:36 INFO - Running post-action listener: _resource_record_post_action 23:51:36 INFO - Running post-run listener: _resource_record_post_run 23:51:37 INFO - Total resource usage - Wall time: 1339s; CPU: 14.0%; Read bytes: 73728; Write bytes: 510562304; Read time: 4484; Write time: 6800972 23:51:37 INFO - install - Wall time: 20s; CPU: 27.0%; Read bytes: 0; Write bytes: 112066560; Read time: 0; Write time: 1237416 23:51:37 INFO - run-tests - Wall time: 1319s; CPU: 13.0%; Read bytes: 73728; Write bytes: 398495744; Read time: 4484; Write time: 5563556 23:51:37 INFO - Running post-run listener: _upload_blobber_files 23:51:37 INFO - Blob upload gear active. 23:51:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:51:37 INFO - Copying logs to upload dir... 23:51:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1378.544136 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2015-12-13 23:51:37.128761) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:51:37.132542) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010079 build_url: 'https://queue.taskcluster.net/v1/task/aeyDGGZVQO64ti8ik0xg7Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:51:37.186160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:51:37.186859) ========= 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=256b35f542ca8bede9e27f1f00000291-1450059199.35311-270474081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:51:37.238180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 23:51:37.238540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 23:51:37.238866) ========= ========= Total master_lag: 0.26 =========