builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1448065594.13 results: success (0) buildid: 20151120144536 builduid: de3de14d31994740bd16a66b44f8334f revision: 9b261cc49a9216e481f8a7006e97f85aede567ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.130160) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.130617) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.130914) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003627 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.145584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.145877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.154067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.154326) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003810 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.201361) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.201627) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.201974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.202245) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 16:26:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-11-20 16:26:34 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.396360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.396663) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:34.446143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 16:26:34.446448) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9b261cc49a9216e481f8a7006e97f85aede567ec --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 9b261cc49a9216e481f8a7006e97f85aede567ec --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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 16:26:34,659 truncating revision to first 12 chars 2015-11-20 16:26:34,659 Setting DEBUG logging. 2015-11-20 16:26:34,659 attempt 1/10 2015-11-20 16:26:34,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9b261cc49a92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:26:35,918 unpacking tar archive at: b2g-inbound-9b261cc49a92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537375 ========= master_lag: 1.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 16:26:37.292732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:37.293064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:37.308318) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:37.308587) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:26:37.308985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-20 16:26:37.309267) ========= /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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:26:37 INFO - MultiFileLogger online at 20151120 16:26:37 in /builds/slave/test 16:26:37 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 16:26:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:26:37 INFO - {'append_to_log': False, 16:26:37 INFO - 'base_work_dir': '/builds/slave/test', 16:26:37 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 16:26:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:26:37 INFO - 'branch': 'B2G-Inbound-Non-PGO', 16:26:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:26:37 INFO - 'config_files': ('talos/linux_config.py',), 16:26:37 INFO - 'default_actions': ('clobber', 16:26:37 INFO - 'read-buildbot-config', 16:26:37 INFO - 'download-and-extract', 16:26:37 INFO - 'populate-webroot', 16:26:37 INFO - 'create-virtualenv', 16:26:37 INFO - 'install', 16:26:37 INFO - 'run-tests'), 16:26:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:26:37 INFO - 'download_minidump_stackwalk': True, 16:26:37 INFO - 'download_symbols': 'ondemand', 16:26:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:26:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:26:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:26:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:26:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:26:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:26:37 INFO - 'installer_path': 'installer.exe', 16:26:37 INFO - 'log_level': 'info', 16:26:37 INFO - 'log_name': 'talos', 16:26:37 INFO - 'log_to_console': True, 16:26:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:26:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:26:37 INFO - 'opt_config_files': (), 16:26:37 INFO - 'pip_index': False, 16:26:37 INFO - 'sps_profile': False, 16:26:37 INFO - 'sps_profile_interval': 0, 16:26:37 INFO - 'suite': 'dromaeojs', 16:26:37 INFO - 'system_bits': '64', 16:26:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:26:37 INFO - 'title': 'talos-linux64-ix-028', 16:26:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:26:37 INFO - 'use_talos_json': True, 16:26:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:26:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:26:37 INFO - 'work_dir': 'build'} 16:26:37 INFO - ##### 16:26:37 INFO - ##### Running clobber step. 16:26:37 INFO - ##### 16:26:37 INFO - Running pre-action listener: _resource_record_pre_action 16:26:37 INFO - Running main action method: clobber 16:26:37 INFO - rmtree: /builds/slave/test/build 16:26:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:26:38 INFO - Running post-action listener: _resource_record_post_action 16:26:38 INFO - ##### 16:26:38 INFO - ##### Running read-buildbot-config step. 16:26:38 INFO - ##### 16:26:38 INFO - Running pre-action listener: _resource_record_pre_action 16:26:38 INFO - Running main action method: read_buildbot_config 16:26:38 INFO - Using buildbot properties: 16:26:38 INFO - { 16:26:38 INFO - "properties": { 16:26:38 INFO - "buildnumber": 196, 16:26:38 INFO - "product": "firefox", 16:26:38 INFO - "script_repo_revision": "production", 16:26:38 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:26:38 INFO - "repository": "", 16:26:38 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 16:26:38 INFO - "buildid": "20151120144536", 16:26:38 INFO - "slavename": "talos-linux64-ix-028", 16:26:38 INFO - "pgo_build": "False", 16:26:38 INFO - "basedir": "/builds/slave/test", 16:26:38 INFO - "project": "", 16:26:38 INFO - "platform": "ubuntu64_hw", 16:26:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:26:38 INFO - "slavebuilddir": "test", 16:26:38 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 16:26:38 INFO - "branch": "b2g-inbound", 16:26:38 INFO - "repo_path": "integration/b2g-inbound", 16:26:38 INFO - "stage_platform": "linux64", 16:26:38 INFO - "builduid": "de3de14d31994740bd16a66b44f8334f", 16:26:38 INFO - "revision": "9b261cc49a9216e481f8a7006e97f85aede567ec" 16:26:38 INFO - }, 16:26:38 INFO - "sourcestamp": { 16:26:38 INFO - "repository": "", 16:26:38 INFO - "hasPatch": false, 16:26:38 INFO - "project": "", 16:26:38 INFO - "branch": "b2g-inbound-linux64-talos", 16:26:38 INFO - "changes": [ 16:26:38 INFO - { 16:26:38 INFO - "category": null, 16:26:38 INFO - "files": [ 16:26:38 INFO - { 16:26:38 INFO - "url": null, 16:26:38 INFO - "name": "https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:26:38 INFO - } 16:26:38 INFO - ], 16:26:38 INFO - "repository": "", 16:26:38 INFO - "rev": "9b261cc49a9216e481f8a7006e97f85aede567ec", 16:26:38 INFO - "who": "kwierso@gmail.com", 16:26:38 INFO - "when": 1448064491, 16:26:38 INFO - "number": 6691259, 16:26:38 INFO - "comments": "Merge m-c to b2ginbound, a=merge", 16:26:38 INFO - "project": "", 16:26:38 INFO - "at": "Fri 20 Nov 2015 16:08:11", 16:26:38 INFO - "branch": "b2g-inbound-linux64-talos", 16:26:38 INFO - "revlink": "", 16:26:38 INFO - "properties": [ 16:26:38 INFO - [ 16:26:38 INFO - "buildid", 16:26:38 INFO - "20151120144536", 16:26:38 INFO - "Change" 16:26:38 INFO - ], 16:26:38 INFO - [ 16:26:38 INFO - "builduid", 16:26:38 INFO - "de3de14d31994740bd16a66b44f8334f", 16:26:38 INFO - "Change" 16:26:38 INFO - ], 16:26:38 INFO - [ 16:26:38 INFO - "pgo_build", 16:26:38 INFO - "False", 16:26:38 INFO - "Change" 16:26:38 INFO - ] 16:26:38 INFO - ], 16:26:38 INFO - "revision": "9b261cc49a9216e481f8a7006e97f85aede567ec" 16:26:38 INFO - } 16:26:38 INFO - ], 16:26:38 INFO - "revision": "9b261cc49a9216e481f8a7006e97f85aede567ec" 16:26:38 INFO - } 16:26:38 INFO - } 16:26:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:26:38 INFO - Running post-action listener: _resource_record_post_action 16:26:38 INFO - ##### 16:26:38 INFO - ##### Running download-and-extract step. 16:26:38 INFO - ##### 16:26:38 INFO - Running pre-action listener: _resource_record_pre_action 16:26:38 INFO - Running main action method: download_and_extract 16:26:38 INFO - mkdir: /builds/slave/test/build/tests 16:26:38 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')]} 16:26:38 INFO - https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/test_packages.json 16:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/test_packages.json 16:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:26:39 INFO - Downloaded 1302 bytes. 16:26:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:26:39 INFO - Using the following test package requirements: 16:26:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:26:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:26:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'jsshell-linux-x86_64.zip'], 16:26:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:26:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:26:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:26:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:26:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:26:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:26:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:26:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:26:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:26: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')]} 16:26:39 INFO - https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:40 INFO - Downloaded 21338691 bytes. 16:26:40 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 16:26:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:40 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 16:26:41 INFO - Return code: 0 16:26:41 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 16:26:41 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')]} 16:26:41 INFO - https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:42 INFO - Downloaded 21338691 bytes. 16:26:42 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 16:26:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:26:42 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 16:26:43 INFO - Return code: 0 16:26:43 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')]} 16:26:43 INFO - https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:44 INFO - Downloaded 11130997 bytes. 16:26:44 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 16:26:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:26:44 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 16:26:44 INFO - Return code: 0 16:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:44 INFO - https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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 16:26:46 INFO - Downloaded 55896125 bytes. 16:26:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:26:46 INFO - mkdir: /builds/slave/test/properties 16:26:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:26:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:26:46 INFO - Contents: 16:26:46 INFO - build_url:https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:26:46 INFO - Running post-action listener: _resource_record_post_action 16:26:46 INFO - Running post-action listener: set_extra_try_arguments 16:26:46 INFO - ##### 16:26:46 INFO - ##### Running populate-webroot step. 16:26:46 INFO - ##### 16:26:46 INFO - Running pre-action listener: _resource_record_pre_action 16:26:46 INFO - Running main action method: populate_webroot 16:26:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:26:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:26:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:26:46 INFO - '../fennec_ids.txt'], 16:26:46 INFO - 'tests': ['tcheck2']}, 16:26:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:26:46 INFO - '--tppagecycles', 16:26:46 INFO - '7'], 16:26:46 INFO - 'tests': ['tsvgm']}}, 16:26:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:26:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:26:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:26:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:26:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:26:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:26:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'tests': ['damp', 'tps']}, 16:26:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['damp', 'tps']}, 16:26:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:26:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:26:46 INFO - 'other': {'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'other_l64': {'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'other_nol64': {'tests': ['a11yr', 16:26:46 INFO - 'ts_paint', 16:26:46 INFO - 'tpaint', 16:26:46 INFO - 'sessionrestore', 16:26:46 INFO - 'sessionrestore_no_auto_restore']}, 16:26:46 INFO - 'svgr': {'tests': ['tsvgx', 16:26:46 INFO - 'tsvgr_opacity', 16:26:46 INFO - 'tart', 16:26:46 INFO - 'tscrollx', 16:26:46 INFO - 'cart']}, 16:26:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['tsvgx', 16:26:46 INFO - 'tsvgr_opacity', 16:26:46 INFO - 'tart', 16:26:46 INFO - 'tscrollx', 16:26:46 INFO - 'cart']}, 16:26:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'tests': ['tp5o']}, 16:26:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'talos_options': ['--e10s'], 16:26:46 INFO - 'tests': ['tp5o']}, 16:26:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'talos_options': ['--xperf_path', 16:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:26:46 INFO - 'tests': ['tp5n']}, 16:26:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:26:46 INFO - 'talos_options': ['--e10s', 16:26:46 INFO - '--xperf_path', 16:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:26:46 INFO - 'tests': ['tp5n']}}, 16:26:46 INFO - 'talos.zip': {'path': '', 16:26:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:26:46 INFO - Running post-action listener: _resource_record_post_action 16:26:46 INFO - ##### 16:26:46 INFO - ##### Running create-virtualenv step. 16:26:46 INFO - ##### 16:26:46 INFO - Running pre-action listener: _resource_record_pre_action 16:26:46 INFO - Running main action method: create_virtualenv 16:26:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:26:46 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 16:26:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:26:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:26:46 INFO - Using real prefix '/usr' 16:26:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:26:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:26:48 INFO - Installing pip.................done. 16:26:48 INFO - Return code: 0 16:26:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:26: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')]} 16:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26: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')]} 16:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:48 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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:26:48 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 16:26:48 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 16:26:48 INFO - Using env: {'DISPLAY': ':0', 16:26:48 INFO - 'HOME': '/home/cltbld', 16:26:48 INFO - 'LANG': 'en_US.UTF-8', 16:26:48 INFO - 'LANGUAGE': 'en_US:en', 16:26:48 INFO - 'LOGNAME': 'cltbld', 16:26:48 INFO - 'MAIL': '/var/mail/cltbld', 16:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:48 INFO - 'MOZ_NO_REMOTE': '1', 16:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:48 INFO - 'NO_EM_RESTART': '1', 16:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:48 INFO - 'PWD': '/builds/slave/test', 16:26:48 INFO - 'SHELL': '/bin/bash', 16:26:48 INFO - 'SHLVL': '1', 16:26:48 INFO - 'TERM': 'linux', 16:26:48 INFO - 'TMOUT': '86400', 16:26:48 INFO - 'USER': 'cltbld', 16:26:48 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:48 INFO - '_': '/tools/buildbot/bin/python'} 16:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:26:49 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 16:26:49 INFO - Cleaning up... 16:26:49 INFO - Return code: 0 16:26:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:49 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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:26:49 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 16:26:49 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 16:26:49 INFO - Using env: {'DISPLAY': ':0', 16:26:49 INFO - 'HOME': '/home/cltbld', 16:26:49 INFO - 'LANG': 'en_US.UTF-8', 16:26:49 INFO - 'LANGUAGE': 'en_US:en', 16:26:49 INFO - 'LOGNAME': 'cltbld', 16:26:49 INFO - 'MAIL': '/var/mail/cltbld', 16:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:49 INFO - 'MOZ_NO_REMOTE': '1', 16:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:49 INFO - 'NO_EM_RESTART': '1', 16:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:49 INFO - 'PWD': '/builds/slave/test', 16:26:49 INFO - 'SHELL': '/bin/bash', 16:26:49 INFO - 'SHLVL': '1', 16:26:49 INFO - 'TERM': 'linux', 16:26:49 INFO - 'TMOUT': '86400', 16:26:49 INFO - 'USER': 'cltbld', 16:26:49 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:49 INFO - '_': '/tools/buildbot/bin/python'} 16:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:26:49 INFO - Downloading/unpacking psutil>=0.7.1 16:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:26:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:26:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:26:51 INFO - Installing collected packages: psutil 16:26:51 INFO - Running setup.py install for psutil 16:26:51 INFO - building 'psutil._psutil_linux' extension 16:26:51 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 16:26:51 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 16:26:51 INFO - building 'psutil._psutil_posix' extension 16:26:51 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 16:26:51 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 16:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:26:51 INFO - Successfully installed psutil 16:26:51 INFO - Cleaning up... 16:26:51 INFO - Return code: 0 16:26:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:26:51 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')]} 16:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:51 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')]} 16:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:51 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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:26:51 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 16:26:51 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 16:26:51 INFO - Using env: {'DISPLAY': ':0', 16:26:51 INFO - 'HOME': '/home/cltbld', 16:26:51 INFO - 'LANG': 'en_US.UTF-8', 16:26:51 INFO - 'LANGUAGE': 'en_US:en', 16:26:51 INFO - 'LOGNAME': 'cltbld', 16:26:51 INFO - 'MAIL': '/var/mail/cltbld', 16:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:51 INFO - 'MOZ_NO_REMOTE': '1', 16:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:51 INFO - 'NO_EM_RESTART': '1', 16:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:51 INFO - 'PWD': '/builds/slave/test', 16:26:51 INFO - 'SHELL': '/bin/bash', 16:26:51 INFO - 'SHLVL': '1', 16:26:51 INFO - 'TERM': 'linux', 16:26:51 INFO - 'TMOUT': '86400', 16:26:51 INFO - 'USER': 'cltbld', 16:26:51 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:51 INFO - '_': '/tools/buildbot/bin/python'} 16:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:26:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:26:51 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 16:26:51 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 16:26:51 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 16:26:51 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 16:26:51 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 16:26:51 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 16:26:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:26:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:26:53 INFO - Installing collected packages: mozsystemmonitor 16:26:53 INFO - Running setup.py install for mozsystemmonitor 16:26:53 INFO - Successfully installed mozsystemmonitor 16:26:53 INFO - Cleaning up... 16:26:53 INFO - Return code: 0 16:26:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:26:53 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 16:26:53 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 16:26:53 INFO - Using env: {'DISPLAY': ':0', 16:26:53 INFO - 'HOME': '/home/cltbld', 16:26:53 INFO - 'LANG': 'en_US.UTF-8', 16:26:53 INFO - 'LANGUAGE': 'en_US:en', 16:26:53 INFO - 'LOGNAME': 'cltbld', 16:26:53 INFO - 'MAIL': '/var/mail/cltbld', 16:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:53 INFO - 'MOZ_NO_REMOTE': '1', 16:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:53 INFO - 'NO_EM_RESTART': '1', 16:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:53 INFO - 'PWD': '/builds/slave/test', 16:26:53 INFO - 'SHELL': '/bin/bash', 16:26:53 INFO - 'SHLVL': '1', 16:26:53 INFO - 'TERM': 'linux', 16:26:53 INFO - 'TMOUT': '86400', 16:26:53 INFO - 'USER': 'cltbld', 16:26:53 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:53 INFO - '_': '/tools/buildbot/bin/python'} 16:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:26:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:26:53 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 16:26:53 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 16:26:53 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 16:26:53 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 16:26:53 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 16:26:53 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 16:26:55 INFO - Downloading blobuploader-1.2.4.tar.gz 16:26:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:26:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:26:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:55 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 16:26:56 INFO - Downloading docopt-0.6.1.tar.gz 16:26:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:26:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:26:56 INFO - Running setup.py install for blobuploader 16:26:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:26:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:26:56 INFO - Running setup.py install for requests 16:26:56 INFO - Running setup.py install for docopt 16:26:56 INFO - Successfully installed blobuploader requests docopt 16:26:56 INFO - Cleaning up... 16:26:56 INFO - Return code: 0 16:26:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:26: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')]} 16:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26: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')]} 16:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:26:56 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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:26:56 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 16:26:56 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 16:26:56 INFO - Using env: {'DISPLAY': ':0', 16:26:56 INFO - 'HOME': '/home/cltbld', 16:26:56 INFO - 'LANG': 'en_US.UTF-8', 16:26:56 INFO - 'LANGUAGE': 'en_US:en', 16:26:56 INFO - 'LOGNAME': 'cltbld', 16:26:56 INFO - 'MAIL': '/var/mail/cltbld', 16:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:56 INFO - 'MOZ_NO_REMOTE': '1', 16:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:56 INFO - 'NO_EM_RESTART': '1', 16:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:56 INFO - 'PWD': '/builds/slave/test', 16:26:56 INFO - 'SHELL': '/bin/bash', 16:26:56 INFO - 'SHLVL': '1', 16:26:56 INFO - 'TERM': 'linux', 16:26:56 INFO - 'TMOUT': '86400', 16:26:56 INFO - 'USER': 'cltbld', 16:26:56 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:56 INFO - '_': '/tools/buildbot/bin/python'} 16:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:26:57 INFO - Running setup.py (path:/tmp/pip-fV3xR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:26:57 INFO - Running setup.py (path:/tmp/pip-YF2YTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:26:57 INFO - Running setup.py (path:/tmp/pip-yYVQRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:26:57 INFO - Running setup.py (path:/tmp/pip-Up8cwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:26:57 INFO - Running setup.py (path:/tmp/pip-1B1GTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:26:57 INFO - Running setup.py (path:/tmp/pip-fgt2zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:26:57 INFO - Running setup.py (path:/tmp/pip-Qihq2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:26:57 INFO - Running setup.py (path:/tmp/pip-Bse2hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:26:57 INFO - Running setup.py (path:/tmp/pip-bw0nd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:26:57 INFO - Running setup.py (path:/tmp/pip-VTXjQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:26:57 INFO - Running setup.py (path:/tmp/pip-H82Uol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:26:57 INFO - Running setup.py (path:/tmp/pip-FvjSzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:26:57 INFO - Running setup.py (path:/tmp/pip-RxZqLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:26:57 INFO - Running setup.py (path:/tmp/pip-CP67Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:26:58 INFO - Running setup.py (path:/tmp/pip-2bccsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:26:58 INFO - Running setup.py (path:/tmp/pip-EwXkxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:26:58 INFO - Running setup.py (path:/tmp/pip-VoGoK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:26:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:26:58 INFO - Running setup.py install for manifestparser 16:26:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:26:58 INFO - Running setup.py install for mozcrash 16:26:58 INFO - Running setup.py install for mozdebug 16:26:58 INFO - Running setup.py install for mozdevice 16:26:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:26:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:26:58 INFO - Running setup.py install for mozfile 16:26:58 INFO - Running setup.py install for mozhttpd 16:26:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:26:58 INFO - Running setup.py install for mozinfo 16:26:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:26:58 INFO - Running setup.py install for mozInstall 16:26:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Running setup.py install for mozleak 16:26:59 INFO - Running setup.py install for mozlog 16:26:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Running setup.py install for moznetwork 16:26:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Running setup.py install for mozprocess 16:26:59 INFO - Running setup.py install for mozprofile 16:26:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Running setup.py install for mozrunner 16:26:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Running setup.py install for mozscreenshot 16:26:59 INFO - Running setup.py install for moztest 16:26:59 INFO - Running setup.py install for mozversion 16:26:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:26:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:26:59 INFO - Cleaning up... 16:27:00 INFO - Return code: 0 16:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:27:00 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 16:27:00 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 16:27:00 INFO - Using env: {'DISPLAY': ':0', 16:27:00 INFO - 'HOME': '/home/cltbld', 16:27:00 INFO - 'LANG': 'en_US.UTF-8', 16:27:00 INFO - 'LANGUAGE': 'en_US:en', 16:27:00 INFO - 'LOGNAME': 'cltbld', 16:27:00 INFO - 'MAIL': '/var/mail/cltbld', 16:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:00 INFO - 'MOZ_NO_REMOTE': '1', 16:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:00 INFO - 'NO_EM_RESTART': '1', 16:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:00 INFO - 'PWD': '/builds/slave/test', 16:27:00 INFO - 'SHELL': '/bin/bash', 16:27:00 INFO - 'SHLVL': '1', 16:27:00 INFO - 'TERM': 'linux', 16:27:00 INFO - 'TMOUT': '86400', 16:27:00 INFO - 'USER': 'cltbld', 16:27:00 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:00 INFO - '_': '/tools/buildbot/bin/python'} 16:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:00 INFO - Running setup.py (path:/tmp/pip-NyMaYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:00 INFO - Running setup.py (path:/tmp/pip-OfsvLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:00 INFO - Running setup.py (path:/tmp/pip-ETFm15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:00 INFO - Running setup.py (path:/tmp/pip-xACF5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:00 INFO - Running setup.py (path:/tmp/pip-ZVwoqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:00 INFO - Running setup.py (path:/tmp/pip-_seGXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:00 INFO - Running setup.py (path:/tmp/pip-ervoiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:00 INFO - Running setup.py (path:/tmp/pip-amc6Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:00 INFO - Running setup.py (path:/tmp/pip-XWodkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:00 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:00 INFO - Running setup.py (path:/tmp/pip-3ptTzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 16:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:00 INFO - Running setup.py (path:/tmp/pip-cDYYFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:01 INFO - Running setup.py (path:/tmp/pip-25Jovg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:01 INFO - Running setup.py (path:/tmp/pip-7ZTenU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:01 INFO - Running setup.py (path:/tmp/pip-Wht9Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:01 INFO - Running setup.py (path:/tmp/pip-ao9qiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:01 INFO - Running setup.py (path:/tmp/pip-kNfYGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:01 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)) 16:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:01 INFO - Running setup.py (path:/tmp/pip-tGAGpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:01 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)) 16:27:01 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)) 16:27:01 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)) 16:27:01 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)) 16:27:01 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)) 16:27:01 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)) 16:27:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27:03 INFO - Downloading blessings-1.5.1.tar.gz 16:27:03 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 16:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:27:03 INFO - Installing collected packages: blessings 16:27:03 INFO - Running setup.py install for blessings 16:27:03 INFO - Successfully installed blessings 16:27:03 INFO - Cleaning up... 16:27:03 INFO - Return code: 0 16:27:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:03 INFO - Reading from file tmpfile_stdout 16:27:03 INFO - Current package versions: 16:27:03 INFO - argparse == 1.2.1 16:27:03 INFO - blessings == 1.5.1 16:27:03 INFO - blobuploader == 1.2.4 16:27:03 INFO - docopt == 0.6.1 16:27:03 INFO - manifestparser == 1.1 16:27:03 INFO - mozInstall == 1.12 16:27:03 INFO - mozcrash == 0.16 16:27:03 INFO - mozdebug == 0.1 16:27:03 INFO - mozdevice == 0.47 16:27:03 INFO - mozfile == 1.2 16:27:03 INFO - mozhttpd == 0.7 16:27:03 INFO - mozinfo == 0.9 16:27:03 INFO - mozleak == 0.1 16:27:03 INFO - mozlog == 3.0 16:27:03 INFO - moznetwork == 0.27 16:27:03 INFO - mozprocess == 0.22 16:27:03 INFO - mozprofile == 0.27 16:27:03 INFO - mozrunner == 6.11 16:27:03 INFO - mozscreenshot == 0.1 16:27:03 INFO - mozsystemmonitor == 0.0 16:27:03 INFO - moztest == 0.7 16:27:03 INFO - mozversion == 1.4 16:27:03 INFO - psutil == 3.1.1 16:27:03 INFO - requests == 1.2.3 16:27:03 INFO - wsgiref == 0.1.2 16:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:03 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 0x7f697cc2dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, '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': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', '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 16:27:03 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 16:27:03 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 16:27:03 INFO - Using env: {'DISPLAY': ':0', 16:27:03 INFO - 'HOME': '/home/cltbld', 16:27:03 INFO - 'LANG': 'en_US.UTF-8', 16:27:03 INFO - 'LANGUAGE': 'en_US:en', 16:27:03 INFO - 'LOGNAME': 'cltbld', 16:27:03 INFO - 'MAIL': '/var/mail/cltbld', 16:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:03 INFO - 'MOZ_NO_REMOTE': '1', 16:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:03 INFO - 'NO_EM_RESTART': '1', 16:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:03 INFO - 'PWD': '/builds/slave/test', 16:27:03 INFO - 'SHELL': '/bin/bash', 16:27:03 INFO - 'SHLVL': '1', 16:27:03 INFO - 'TERM': 'linux', 16:27:03 INFO - 'TMOUT': '86400', 16:27:03 INFO - 'USER': 'cltbld', 16:27:03 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:03 INFO - '_': '/tools/buildbot/bin/python'} 16:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 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)) 16:27:03 INFO - Cleaning up... 16:27:03 INFO - Return code: 0 16:27:03 INFO - Running post-action listener: _resource_record_post_action 16:27:03 INFO - Running post-action listener: _start_resource_monitoring 16:27:03 INFO - Starting resource monitoring. 16:27:03 INFO - ##### 16:27:03 INFO - ##### Running install step. 16:27:03 INFO - ##### 16:27:03 INFO - Running pre-action listener: _resource_record_pre_action 16:27:03 INFO - Running main action method: install 16:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:04 INFO - Reading from file tmpfile_stdout 16:27:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:27:04 INFO - Reading from file tmpfile_stdout 16:27:04 INFO - Output received: 16:27:04 INFO - Usage: mozinstall [options] installer 16:27:04 INFO - Options: 16:27:04 INFO - -h, --help show this help message and exit 16:27:04 INFO - -d DEST, --destination=DEST 16:27:04 INFO - Directory to install application into. [default: 16:27:04 INFO - "/builds/slave/test"] 16:27:04 INFO - --app=APP Application being installed. [default: firefox] 16:27:04 INFO - mkdir: /builds/slave/test/build/application 16:27:04 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'] 16:27:04 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 16:27:18 INFO - Reading from file tmpfile_stdout 16:27:18 INFO - Output received: 16:27:18 INFO - /builds/slave/test/build/application/firefox/firefox 16:27:18 INFO - Running post-action listener: _resource_record_post_action 16:27:18 INFO - ##### 16:27:18 INFO - ##### Running run-tests step. 16:27:18 INFO - ##### 16:27:18 INFO - Running pre-action listener: _resource_record_pre_action 16:27:18 INFO - Running main action method: run_tests 16:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:27:18 INFO - Python 2.7.3 16:27:18 INFO - Return code: 0 16:27:18 INFO - grabbing minidump binary from tooltool 16:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:18 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 0x15fab70>, '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 0x164bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164c250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:27:18 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 16:27:18 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 16:27:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:27:18 INFO - Return code: 0 16:27:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:27:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:27:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:27:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:27:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:27:18 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/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test/build 16:27:18 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/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 16:27:18 INFO - Using env: {'DISPLAY': ':0', 16:27:18 INFO - 'HOME': '/home/cltbld', 16:27:18 INFO - 'LANG': 'en_US.UTF-8', 16:27:18 INFO - 'LANGUAGE': 'en_US:en', 16:27:18 INFO - 'LOGNAME': 'cltbld', 16:27:18 INFO - 'MAIL': '/var/mail/cltbld', 16:27:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:27:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:18 INFO - 'MOZ_NO_REMOTE': '1', 16:27:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:18 INFO - 'NO_EM_RESTART': '1', 16:27:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:18 INFO - 'PWD': '/builds/slave/test', 16:27:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:27:18 INFO - 'SHELL': '/bin/bash', 16:27:18 INFO - 'SHLVL': '1', 16:27:18 INFO - 'TERM': 'linux', 16:27:18 INFO - 'TMOUT': '86400', 16:27:18 INFO - 'USER': 'cltbld', 16:27:18 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928', 16:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:18 INFO - '_': '/tools/buildbot/bin/python'} 16:27:18 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/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 16:27:19 INFO - mozversion INFO | application_buildid: 20151120144536 16:27:19 INFO - mozversion INFO | application_changeset: 9b261cc49a9216e481f8a7006e97f85aede567ec 16:27:19 INFO - mozversion INFO | application_display_name: Nightly 16:27:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:27:19 INFO - mozversion INFO | application_name: Firefox 16:27:19 INFO - mozversion INFO | application_remotingname: firefox 16:27:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:27:19 INFO - mozversion INFO | application_vendor: Mozilla 16:27:19 INFO - mozversion INFO | application_version: 45.0a1 16:27:19 INFO - mozversion INFO | platform_buildid: 20151120144536 16:27:19 INFO - mozversion INFO | platform_changeset: 9b261cc49a9216e481f8a7006e97f85aede567ec 16:27:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:27:19 INFO - mozversion INFO | platform_version: 45.0a1 16:27:19 INFO - 2015-11-20 16:27:19,122 DEBUG : using testdate: 1448065639 16:27:19 INFO - 2015-11-20 16:27:19,122 DEBUG : actual date: 1448065639 16:27:19 INFO - 2015-11-20 16:27:19,170 INFO : starting webserver on 'localhost:56683' 16:27:19 INFO - 2015-11-20 16:27:19,171 INFO : Starting test suite talos-linux64-ix-028 16:27:19 INFO - 2015-11-20 16:27:19,171 INFO : Starting test dromaeo_css 16:27:19 INFO - 2015-11-20 16:27:19,171 DEBUG : operating with platform_type : linux_ 16:27:19 INFO - 2015-11-20 16:27:19,172 INFO : Initialising browser for dromaeo_css test... 16:27:19 INFO - 2015-11-20 16:27:19,186 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1554h/profile http://localhost:56683/getInfo.html 16:27:23 INFO - 2015-11-20 16:27:23,125 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:27:23 INFO - 2015-11-20 16:27:23,126 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:27:23 INFO - 2015-11-20 16:27:23,126 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:27:23 INFO - 2015-11-20 16:27:23,126 DEBUG : BROWSER_OUTPUT: __metrics 16:27:23 INFO - 2015-11-20 16:27:23,230 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:27:24 INFO - 2015-11-20 16:27:24,555 INFO : Browser initialized. 16:27:24 INFO - 2015-11-20 16:27:24,556 INFO : Running cycle 1/1 for dromaeo_css test... 16:27:24 INFO - 2015-11-20 16:27:24,556 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1554h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:27:36 INFO - 2015-11-20 16:27:36,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 140595200 16:27:36 INFO - 2015-11-20 16:27:36,421 DEBUG : BROWSER_OUTPUT: 16:28:27 INFO - 2015-11-20 16:28:27,934 DEBUG : BROWSER_OUTPUT: 1448065707930 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] 16:30:40 INFO - 2015-11-20 16:30:40,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56683/tests/dromaeo/cssquery-ext.html) 16:30:41 INFO - 2015-11-20 16:30:41,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 242794496 16:30:41 INFO - 2015-11-20 16:30:41,465 DEBUG : BROWSER_OUTPUT: 16:33:44 INFO - 2015-11-20 16:33:44,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-ext.html (next: http://localhost:56683/tests/dromaeo/cssquery-jquery.html) 16:33:44 INFO - 2015-11-20 16:33:44,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 217653248 16:33:44 INFO - 2015-11-20 16:33:44,587 DEBUG : BROWSER_OUTPUT: 16:36:46 INFO - 2015-11-20 16:36:46,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56683/tests/dromaeo/cssquery-mootools.html) 16:36:47 INFO - 2015-11-20 16:36:47,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 222806016 16:36:47 INFO - 2015-11-20 16:36:47,269 DEBUG : BROWSER_OUTPUT: 16:39:49 INFO - 2015-11-20 16:39:49,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56683/tests/dromaeo/cssquery-prototype.html) 16:39:49 INFO - 2015-11-20 16:39:49,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 208048128 16:39:49 INFO - 2015-11-20 16:39:49,785 DEBUG : BROWSER_OUTPUT: 16:42:52 INFO - 2015-11-20 16:42:52,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56683/tests/dromaeo/cssquery-yui.html) 16:42:53 INFO - 2015-11-20 16:42:53,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 203907072 16:42:53 INFO - 2015-11-20 16:42:53,184 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/dromaeo/cssquery-yui.html (next: http://localhost:56683/tests/dromaeo/cssquery-dojo.html) 16:45:55 INFO - 2015-11-20 16:45:55,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 263434240 16:45:55 INFO - 2015-11-20 16:45:55,891 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,891 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:45:55 INFO - 2015-11-20 16:45:55,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:45:55 INFO - 2015-11-20 16:45:55,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:45:55 INFO - 2015-11-20 16:45:55,891 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:45:55 INFO - 2015-11-20 16:45:55,893 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2653.9734602653975;2725.904593339232;2731.8360898346114;2742.7531522163013;2757.600147978543;4477.08219814938;4613.377194078798;4660.743659098753;4713.010267843752;4720.291956206575;4617.353570500132;4636.2581986882105;4733.881652958669;4737.455192652846;4748.169070412672;4352.281873490886;4355.825766969318;4376.97811510942;4392.736435813846;4412.97793511032;4216.3464662977285;4399.142167277382;4408.4709834819705;4447.510773814878;4460.442444694413;4219.38818871262;4298.075913678543;4304.80628371724;4319.654427645781;4323.265044942336;4343.717658352197;4345.174416860787;4345.1961387143165;4351.325544540601;4388.868333949955;4102.261592913274;4320.416743739586;4324.113556720896;4334.9783251083545;4373.912521749579;4466.419365482499;4506.324051392285;4550.226461501553;4645.907081858344;4680.9297860532115;5061.620378471629;5099.107656160194;5104.25988231708;5105.132127538291;5148;4841.055994081155;5133.25567792668;5140.794368225266;5147.639665223436;5154.716490593016;4581.9541804582195;4582.725036497821;4603.631709463235;4617.907641847144;4690.953090469052;5171.224316352502;5187.221916712448;5187.559057480156;5190.377154741455;5236.240745092016;4666.1834179019215;4965.751712414365;4971.90056198874;4973.701577905337;5023.547880690755;4935.136351138536;4940.6788558743565;4968.428630707443;5038.34501514808;5063.215201643751;4952.331435256267;4970.428400733889;4976.328195693607;4984.22744474607;5019.67372120811;4736.029114031615;4931.3835770528685;4935.136351138536;4947.158982972904;4989.326440930428;4099.631033206966;4108.897277568085;4119.320312148462;4162.375643653476;4163.167366526707;3636.581793093775;3643.216708407705;3656.524651795303;3679.2089700714473;3683.4106542953537;4317.740935543878;4340.934885976713;4345.044090300129;4350.434443522322;4378.036831896978;4760.119377915097;4936.531029552187;4939.827106051271;4940.308356830046;4941.851744447672;4364.8254069837485;4367.170237654836;4373.453318335208;4388.802503887333;4403.427554417905;4488.371627972087;4491.483479399845;4492.213862574036;4493.281075028045;4528.592426681615;4541.091781643619;4655.883602909955;4658.417697787777;4795.184818580849;4802.615790736662;4955.132851750857;5037;5039.118154323052;5040.14317566022;5088.236764485357;4808.302796094476;4851.054044461296;4879.536444037811;4883.194272944925;4919.0899683558655;4791.592714619296;4891.559759621651;4901.215805471107;5036.974815125901;5120.795168193231;4997.800087996439;5075.314832497713;5077.136886729339;5095.388553373619;5106.46382129871;4875.975620122019;4877.9024419512125;4883.413990321184;4885.609151267961;4926.802927882844;4647.62818974488;4760.59534939534;4881.194602890483;4882.2432522959;4929.482404347492;4715.3869996900185;4758.500357462555;4867.075255701406;4869.610431165569;4877.024595081069;4960.255961605788;4974.403071631427;4999.750012499288;5008.373953255843;5014.07239660664;4866.513348665247;4872.805087796591;4904.558589726942;4916.508349165055;4955.40535135786 16:45:55 INFO - 2015-11-20 16:45:55,894 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.1343131577371;566.9603127781056;568.9630174038687;579.6290374160538;591.9911201331978;28108.859455702717;28756.712432875665;36883.81558092209;37704.05739856505;37907;40062.596244225366;40363.192736145334;40363.79818100906;40487.79756101223;40495.59504404955;7028.753993610225;7870.881936770938;8058.476199047072;8072.475289106219;8130.349572034253;7102.289771022883;9924.354916930413;10079;10116.241281903849;10116.393016419039;10199.490025498733;10302.7424314392;10303.330283531546;10303.742406439824;10319;7222.711091556332;7418.814529636748;10023.148032417253;10126.44304563245;10177;9770;9890.703278901645;9891.20870330379;9894.10953014225;9903.950480247624;37440.87677369683;37791.43312850309;37877;37886.43170352447;37987;2732.27594687408;2862.1413575927345;2868.1969048666406;3144.68553144686;3365.612954510238;28644;28650.283742906384;28774.136775896757;28849.71150288491;29476.26309342262;3389.389909816232;3554.8578056877695;3565.322588708137;3579.3020361029608;3682.355587772156;226502;228496;229023;229418;230527;52500.73749631227;53484.73257633687;53498.46501535013;56844.431555683914;57359.713201433726;48883.75558122258;61907.690461547405;62422;63014.68492657507;63061;12915.612531624067;12918.547850825176;12985.350732463528;13021.153625014344;13095;9192.63229470827;9196.954015229881;9202.171804537624;9207.309451791143;9225.446473211628;19363.224171286463;19581.902090489457;19734;19734.901325493567;19848.90075549642;7809.180036096242;8107.135358867494;8117.837643247102;8120.309773669304;8134.105248422668;818.8607936650784;837.7486753973783;950.4819873169139;955.6416343871049;967.0619499085875;26446;26729.465410692068;30648;31487.37025259482;31676;930.9162175404247;944.730751735752;1023.744063984004;1078.7087486378791;1101.3502033800096;13807.240601766798;13963.930180349033;14057.367418466194;14133.71732565343;14158.433662653379;317713;319902;322032;322068;322875;43790.34314485285;44721.10557788826;48266;48301.275480867815;48996;1185.9187126592947;1223.3088305107763;1227.7483115961206;1232.8582213045436;1237.0845574275152;28225.576616351183;28734.568981465713;29224.853875731336;29495.410091798472;29570;33894.15264618404;34559.13602159966;39698.40452393159;40381.192376151725;41485.377719334836;194858;195199;195978;196265;196887;28492.287692807844;28839.7116028837;28892.277693057;28971.85514072416;28973.420531589672;36463.45304820483;37486;37953.62046379611;42818.148431218746;44103.33844992392;34825.65174348224;35987.95949286345;36029;36508.26983460369;37024;35867.28265434624;35882.82058589795;36580.45129323009;36781.816090920445;36983.815080924425;35202.823985879906;35991.82004089963;36210.637893620726;36253;36265.637343627284;32560.18599534936;32808.88546918061;33034.504482432305;33050.22082775439;33464.83267583744;25104.246872593852;25225.87387063053;25365.61951570691;25403.491930161665;25973.740262597134 16:45:55 INFO - 2015-11-20 16:45:55,895 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.9595648522178;340.59639327397036;340.6661471757677;341.43833394066746;342.33074339665956;12311.015118790498;12875;15182.772258416118;15303.464378746732;17352;13832.861671383283;14352.641183970405;14861.92569037156;15202.619934501643;15297.923510382432;4980.750962451881;5022.673526220784;5125.333706618153;5199.714015729133;5214.843554693346;3339.6159441664154;3460.359833430811;5163.096458119833;5217.191335343028;5394.05604019297;5321.148616221405;5339.439358867321;5373.032854086263;5387.488188622095;5391.218273350361;4936.308916751657;5335.146376579748;5432.293801805779;5436.994156081138;5440.102383106782;5216.895662086775;5232.895342093175;5234.842954711365;5239.973800131013;5241.842744717626;12242.143049986504;15506.61233469161;17911.641767164583;18888.05559722022;18901.243950241973;1675.2126500544725;1784.5092599535233;1803.431918945528;1919.0255104587973;1926.2969016309087;8757.605907734167;8977.596008179647;9049;9073.81852362949;11182.105431565455;1683.267778516337;1695.93216271349;1734.2369357482794;1756.7628370169991;1780.9910950445164;48800.75599621979;51216.487835121916;53044;57020.714896425256;59509.404905951254;9500.287478439144;9531.428114313025;9583.712488625353;9649.228061755042;9914.801703966024;11855;11891.037978733586;11897.34564598938;11901.583444579399;11904.404779760976;6646.836803559455;6661.4004739573675;6667.266600673922;6704.497162712816;6723.159605049369;6300.27546832111;6308.243010838729;6326.145970293951;6343.555951083472;6345.143405640272;3949.289127956938;4075.5109386873764;4211.578842115825;4242.5121111072;4246.936295955563;1615.830337814536;1652.9504114876572;1669.7495375693743;1674.0792564089702;1678.337056862557;796.8525822722814;870.656090844113;924.306769922558;953.5804246131819;961.3606951377255;12939.353032348345;14435.206063666388;14786.778198327034;15572.688546229012;16052.357905683642;746.8356961468468;851.2551517422255;855.2302927365421;859.657433493737;863.3179787967435;8683.696070637623;8688.478691278544;8740.825183496294;8934.553272336487;8949.552522373855;478218;480796;484290;499336;505350;67887.66056169687;69630.3036969634;70337.2966270341;71215;71381;1098.368438148052;1101.509828126492;1109.6837401340579;1130.7342774447998;1138.573035111833;13780.65548361299;13841.30793460343;13936.372863221382;14058.78911816344;14184.787228191792;30150.849245754507;30467.542986854773;31369.686303136677;31399.686003139675;31861.20346991344;41912.790436047624;42085.78957105195;42434.15131697411;42859.571404286806;43434.78282608567;8896.377253592187;8911.880841705351;8940.329475289509;9020.774480638036;9077.500737459502;10439.164866810788;10486;10554.261201715806;10635.415052172204;14842.554723358317;13446.193228406328;13470;13682.247476388497;13717.794233086712;13887.652808679459;13123.146995445266;13131.474741010252;13195.868041319463;13724.725505490034;13802.033857629869;12898.48406063747;12915.418806153933;13128.540501082416;13251.271180085188;13748;7587.317141457295;7631.580263085583;7749.225077492206;8062.274395304451;8850.20348168668;9533.809323813346;13323.267220302589;13590.79613805774;13959.790603141164;14201.715965680834 16:45:55 INFO - 2015-11-20 16:45:55,897 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1369.7329020840934;1426.3153686230612;1518.9772153417694;1593.9400298801297;1705.7356109802977;5616.32604087509;5726.541876649869;6458.160439142911;6812.046313516112;6813.829654258646;5904.350521442638;6512.283648798629;6731.899021514681;6749.49378796591;6755.797326080213;2014.0936578539643;2080.115950720945;2085.082563671987;2086.405374468277;2091.4144039668918;1746.4498682914905;1794.2374490841405;2028.4117605894273;2078.282992367631;2083.4583008417767;2042.3566576528347;2047.2322878920404;2052.0663098290242;2053.37372101509;2054.352878843167;1994.3917105282883;2019.798020197983;2040.0411806450945;2040.8265297449586;2040.9489762755902;2061.989690051555;2080.095158605996;2091.9477013074793;2106.820920221783;2108.8312934965165;6373.330800265951;6413.422791948747;6419.486441084702;6423.389777971085;6426.164598602152;3991.980040099781;4071.124708187724;4072.5112986441522;4085.775282359469;4092.8158232879296;2693.7575618194455;2725.74105459981;2773.791965602568;2775.417162395899;2798.5242508773354;815.4251252866715;843.7342237195264;865.2126564826041;872.8603423452217;876.6055275126218;8888.111188881125;8891.822163556757;8913.821723565492;8925.687600933936;8932.955335223347;3782.867599634;3819.503464549646;3855.151866589346;3878.2243551289853;3942.0539070623418;7714.614269286513;7734.03324584427;7739.380849532024;7751.379889608817;7754.263344982218;4109.568495308009;4118.320477121301;4122.876313710593;4123.340265557496;4130.463039804806;3724.273766615538;3738.813059347022;3746.8501259949844;3753.3994560870674;3761.586225515191;3359.5800524934384;3370.292238629915;3379.5775528058994;3381.408253555618;3414.4195486767308;875.5403413208116;968.6319198704447;1035.2597892506894;1100.7028102412303;1130.7173206698326;897.0580890065405;898.8876390451194;968.3028219681818;1056.2236755984345;1168.7428765671539;6420.133282006869;6467.741290348427;6477.4494167996245;6493.577917435352;6498.122753428322;1018.2363227579316;1027.814993301198;1032.3599368391644;1033.188946676855;1068.3376306689747;4808.783604737795;4878;4912.508749125131;4918.803247870045;4921.557059864558;7498.925010749932;7558.886616700754;7634.236576342432;7651.617419129021;7678.846423071507;7618.276263754934;7665.731699390494;7668.616569171519;7684.846303073908;7698.884516732253;6091.939080609226;6163.322034576193;6200.131981522591;6202.100695399142;6212.844678883064;5685.061964775766;5773.884522309446;5776.046952252831;5780.5953583248765;5786.247787787561;6762.357576030269;6791.89812152828;6898.310168983062;6971.093757811452;6997.195322537769;6999.580025198505;7005.684744186422;7072.646367681698;7083.043789088407;7194.280571942764;6051.12258722474;6129.816105516842;6133.969330153499;6134.35589263121;6146.631202127886;6419.133416988833;6444.484441244783;6473.255575608677;6478.708458119301;6482.319356467691;5337.6797392156595;5474.288342515448;5980.222571065734;6061.939380606137;6214.5960512568345;5883.970580147072;5930.377310382348;6102.847428814315;6117.0824376342125;6127.632342059491;6159.81520554384;6188.44304012641;6201.96899015502;6202.255729312511;6207.565470417027;5656.123300888369;5696.971515142398;5700.971495142498;5710.257666503494;5719.170720245625;5697.898079991167;5716.514096301861;5741.598355580838;5743.0811070228565;5764.654120752768 16:45:55 INFO - 2015-11-20 16:45:55,900 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.39671133068845;318.5317583152765;319.1192309226534;320.34009939524566;320.7321886225002;5366.731663416828;5392.7303634818245;5410.404855465896;5430.185472179165;5444.047291723942;5121.8463446096675;5176.870578235536;5236.031334203175;5314.671332166959;5371.328583927009;4191.811368488426;4210.073783767566;4216.3464662977285;4221.26127927613;4227.8097485613225;3991.7604943703473;4195.328747400416;4216;4222.704410691253;4231.090315582149;4045.0898547826796;4054.2499637567;4119.958800411988;4121.5672354402805;4144.606262405066;4139.2135494256145;4151.356539736345;4170.16596680665;4183.267928112568;4192.601702838241;3683.336999340118;3686.318031164243;3687.8893633191046;3690.132818787583;3690.335739566877;5120.411152717448;5140.948590514122;5147.639665223436;5152.742362881841;5154.587632989352;4645.187092258841;4751.192297309466;4757.191277482836;4768.403949506312;4823.927641085386;5616.213730077751;5680.0627896397045;5689.772409103631;5691.174779656926;5691.51622112121;3962.623550762673;3968.6825053995613;3969.9876531484574;3970.602939706035;3972.165845172517;5851.76592936282;5946.881062378771;5956.55325850563;5959.404059594092;5963.344032156459;3945.467361906106;4087.9182416351505;4091.5499295077516;4095.6313931746286;4105.44576482177;4139.91720165595;4147.294959856831;4147.834086636561;4155.10665206982;4170.708050436501;4765.356676848651;4775.6657034007985;4778.713277203379;4785;4787.521247875185;5682.573806964411;5685.715714214272;5685.948099601587;5699.002674532023;5699.059655156935;1423.1176670464379;1448.4930274403873;1463.7657974723993;1464.0337377330911;1464.985350146485;961.7403301108661;990.9405435673883;991.4893829677721;993.4635296939716;1002.3484734922358;4876.878078048077;4893.95106048942;4894.461609222983;4898.461169271377;4898.951010489921;5771.913421298684;5774.566907481955;5797.913031304533;5803.129530570448;5804.419558044162;4801.1117943180625;4895.216765317603;4895.461499235082;4936.086823937583;5018.04657115147;3165.4776961801044;3176.269458024667;3189.3940151371166;3203.583534140547;3204.3110731192905;5585.385607583163;5586.35756887955;5586.888262234733;5589.105743081088;5589.916151257735;5887.2052272943465;6048.818535443944;6068.4538391544975;6068.51451883857;6080.604760690541;5593.8601534961135;5601.159826026129;5613.803516876971;5614.466625670555;5615.578831587647;5915.171875937458;5929.466348028698;5930.991731405585;5934.465898069195;5941.643501389931;5779.364269930388;5787.797427090031;5790.913136302875;5792.1311803229855;5802.390748971297;5443.074677304789;5591.021571224938;5618.101103823368;5621.016322143527;5621.100623900156;4191.266528357464;4229.640480559064;4240.724352917051;4242.639375653104;4251.681123915657;5881.206037185097;5891.852703682271;5894.381089985662;5896.64620122794;5898.262717160355;5532.751026203911;5653.858653533694;5662.348829884616;5663.348714897839;5667.744951477111;5648.350439699323;5650.180723795109;5653;5657.179708942263;5659.660420374791;5530.474604912527;5544.1960915667805;5544.279243698294;5547.251121098761;5549.0289199389135;5660.433956604306;5683.261176047087;5684.062129748545;5691.971540142273;5696.772129114789;5469.808556700656;5610.354809196831;5612.579056570692;5616;5622.128570071482 16:45:55 INFO - 2015-11-20 16:45:55,902 DEBUG : BROWSER_OUTPUT: |5;yui.html;630.9526785491089;673.6126727131899;684.780870121561;724.6883839948822;734.2804052029009;11155.442227888603;11369.204155709092;11373.545058197673;12693.682657933556;12874.549390771324;14069.92965035176;14149.36327865246;14163.716725665481;14177.07848989815;14179.078359906625;620.3269452643887;626.9059641053833;789.1831953927687;790.699534177012;804;795.2008231727107;798.2057852436805;799.7960520067375;804.9154838741936;805.0138580239219;654.3325807676167;832.862577674686;840.794005468661;841.1126261793805;842.086336325088;658.6245839871275;825.0923983618032;832.9333653307721;834.2158371131118;839.4795226959294;616.7471336751955;617.9969100154516;618.001926888077;618.1407843098098;618.1562167641182;11119.499622517005;11151.888481115166;11173.49719262627;11199;11208.15938804593;10717.892821071768;11135.665930022113;11158.832617510743;11402.429878506124;11812.940935295355;8972.147645973622;9000.504972226525;9011.909880901238;9216.262698984065;9437.150656440954;3159.3207460396125;3161.3835302116095;3189.649138594753;3225.645179030305;3234.91912702182;42923.35614965778;43338.566614333766;43340.13319733619;43428.56571434309;43453.565464345265;8633.266172375294;8760.912390876138;8786.209241168326;8791;8914.777130571787;16483.175841207893;16554.089525076237;16586.668266634842;16591.170441477876;16595.41916032933;6338.080978258126;6413.967930160413;6491.545591808623;6606.900896486556;6621.33786621334;3578.9284214315567;3613.605333705416;3614.313280476701;3627.7460577759302;3635.763675361093;2661.321363052448;2697.7167397422986;2704.337437327867;2709.43101948593;2711.891524339044;469.85904228731926;475.028566581342;479.4222961331587;482.73932076678904;483.90080033593733;497.2044728434476;572.6449601247253;602.4818655955875;610.5042349402362;640.9839754006188;7433.776986690408;7855.175206603224;7867.449278550446;7962.203779621991;8085.231902969209;506.6402853973646;542.395229319314;592.4874983139639;603.6217303822924;608.9451949324493;3624.637536246407;3703.518542589446;3722.013666378412;3800.2969450651717;3834.6357096075826;49194.75402622964;50206;50487.24269135966;51152.74423627932;51261;44228.557714422444;44847.10305793931;45074.54925450704;45395.773021134686;46100;41894.58105418968;41960.370594441105;42748.572514274456;42922;43291.35062974058;7224.74713385029;7370.226126256666;8064.717734879251;8251.463654862415;8461.223552435744;30546.389072218877;31506.842465787526;31517;31780.36439271248;33429.662813487186;40723.59276407198;40755.16601752869;40953.18093638051;40955.1808963825;41622;9454.527273636428;9761.853572196565;9905.752356191153;10037.69886903394;10110.69667909964;11423.714407139889;11425.143114266297;11540.596079137189;11585.362805045803;11630.825537617111;10043.246756493147;10133.44266065344;10212.642557510748;10280.588776448858;11013.229073965065;10687.465626718478;11005.119590432907;11120.555177793121;11263.436828158396;11274.267172633752;10406.479676016017;10891.400972946563;10920.945395272973;11001.78980312181;11250.324980501196;9071.138241867013;9217.861732074158;9337.388186113598;9417.858732118886;9811.460369679737;8850.867236991322;8870.246029087342;8952.820943581222;9063.909360906306;9175.128362805523 16:45:55 INFO - 2015-11-20 16:45:55,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:45:55 INFO - 2015-11-20 16:45:55,902 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:45:55 INFO - 2015-11-20 16:45:55,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,963 16:45:55 INFO - 2015-11-20 16:45:55,903 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:45:55 INFO - 2015-11-20 16:45:55,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066755889__endTimestamp 16:45:55 INFO - 2015-11-20 16:45:55,903 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,904 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:45:55 INFO - 2015-11-20 16:45:55,904 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:45:55 INFO - 2015-11-20 16:45:55,904 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,904 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4638.58 Median:4758.50 stddev:483.13 (10.2%) stddev-sans-first:458.84 16:45:55 INFO - 2015-11-20 16:45:55,905 DEBUG : BROWSER_OUTPUT: Values: 2654.0 2725.9 2731.8 2742.8 2757.6 4477.1 4613.4 4660.7 4713.0 4720.3 4617.4 4636.3 4733.9 4737.5 4748.2 4352.3 4355.8 4377.0 4392.7 4413.0 4216.3 4399.1 4408.5 4447.5 4460.4 4219.4 4298.1 4304.8 4319.7 4323.3 4343.7 4345.2 4345.2 4351.3 4388.9 4102.3 4320.4 4324.1 4335.0 4373.9 4466.4 4506.3 4550.2 4645.9 4680.9 5061.6 5099.1 5104.3 5105.1 5148.0 4841.1 5133.3 5140.8 5147.6 5154.7 4582.0 4582.7 4603.6 4617.9 4691.0 5171.2 5187.2 5187.6 5190.4 5236.2 4666.2 4965.8 4971.9 4973.7 5023.5 4935.1 4940.7 4968.4 5038.3 5063.2 4952.3 4970.4 4976.3 4984.2 5019.7 4736.0 4931.4 4935.1 4947.2 4989.3 4099.6 4108.9 4119.3 4162.4 4163.2 3636.6 3643.2 3656.5 3679.2 3683.4 4317.7 4340.9 4345.0 4350.4 4378.0 4760.1 4936.5 4939.8 4940.3 4941.9 4364.8 4367.2 4373.5 4388.8 4403.4 4488.4 4491.5 4492.2 4493.3 4528.6 4541.1 4655.9 4658.4 4795.2 4802.6 4955.1 5037.0 5039.1 5040.1 5088.2 4808.3 4851.1 4879.5 4883.2 4919.1 4791.6 4891.6 4901.2 5037.0 5120.8 4997.8 5075.3 5077.1 5095.4 5106.5 4876.0 4877.9 4883.4 4885.6 4926.8 4647.6 4760.6 4881.2 4882.2 4929.5 4715.4 4758.5 4867.1 4869.6 4877.0 4960.3 4974.4 4999.8 5008.4 5014.1 4866.5 4872.8 4904.6 4916.5 4955.4 16:45:55 INFO - 2015-11-20 16:45:55,905 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,905 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41678.61 Median:19378.84 stddev:66357.28 (342.4%) stddev-sans-first:66471.61 16:45:55 INFO - 2015-11-20 16:45:55,906 DEBUG : BROWSER_OUTPUT: Values: 562.1 567.0 569.0 579.6 592.0 28108.9 28756.7 36883.8 37704.1 37907.0 40062.6 40363.2 40363.8 40487.8 40495.6 7028.8 7870.9 8058.5 8072.5 8130.3 7102.3 9924.4 10079.0 10116.2 10116.4 10199.5 10302.7 10303.3 10303.7 10319.0 7222.7 7418.8 10023.1 10126.4 10177.0 9770.0 9890.7 9891.2 9894.1 9904.0 37440.9 37791.4 37877.0 37886.4 37987.0 2732.3 2862.1 2868.2 3144.7 3365.6 28644.0 28650.3 28774.1 28849.7 29476.3 3389.4 3554.9 3565.3 3579.3 3682.4 226502.0 228496.0 229023.0 229418.0 230527.0 52500.7 53484.7 53498.5 56844.4 57359.7 48883.8 61907.7 62422.0 63014.7 63061.0 12915.6 12918.5 12985.4 13021.2 13095.0 9192.6 9197.0 9202.2 9207.3 9225.4 19363.2 19581.9 19734.0 19734.9 19848.9 7809.2 8107.1 8117.8 8120.3 8134.1 818.9 837.7 950.5 955.6 967.1 26446.0 26729.5 30648.0 31487.4 31676.0 930.9 944.7 1023.7 1078.7 1101.4 13807.2 13963.9 14057.4 14133.7 14158.4 317713.0 319902.0 322032.0 322068.0 322875.0 43790.3 44721.1 48266.0 48301.3 48996.0 1185.9 1223.3 1227.7 1232.9 1237.1 28225.6 28734.6 29224.9 29495.4 29570.0 33894.2 34559.1 39698.4 40381.2 41485.4 194858.0 195199.0 195978.0 196265.0 196887.0 28492.3 28839.7 28892.3 28971.9 28973.4 36463.5 37486.0 37953.6 42818.1 44103.3 34825.7 35988.0 36029.0 36508.3 37024.0 35867.3 35882.8 36580.5 36781.8 36983.8 35202.8 35991.8 36210.6 36253.0 36265.6 32560.2 32808.9 33034.5 33050.2 33464.8 25104.2 25225.9 25365.6 25403.5 25973.7 16:45:55 INFO - 2015-11-20 16:45:55,906 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,906 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25950.81 Median:23148.68 stddev:79971.11 (345.5%) stddev-sans-first:80172.32 16:45:55 INFO - 2015-11-20 16:45:55,907 DEBUG : BROWSER_OUTPUT: Values: 337.0 340.6 340.7 341.4 342.3 12311.0 12875.0 15182.8 15303.5 17352.0 13832.9 14352.6 14861.9 15202.6 15297.9 4980.8 5022.7 5125.3 5199.7 5214.8 3339.6 3460.4 5163.1 5217.2 5394.1 5321.1 5339.4 5373.0 5387.5 5391.2 4936.3 5335.1 5432.3 5437.0 5440.1 5216.9 5232.9 5234.8 5240.0 5241.8 12242.1 15506.6 17911.6 18888.1 18901.2 1675.2 1784.5 1803.4 1919.0 1926.3 8757.6 8977.6 9049.0 9073.8 11182.1 1683.3 1695.9 1734.2 1756.8 1781.0 48800.8 51216.5 53044.0 57020.7 59509.4 9500.3 9531.4 9583.7 9649.2 9914.8 11855.0 11891.0 11897.3 11901.6 11904.4 6646.8 6661.4 6667.3 6704.5 6723.2 6300.3 6308.2 6326.1 6343.6 6345.1 3949.3 4075.5 4211.6 4242.5 4246.9 1615.8 1653.0 1669.7 1674.1 1678.3 796.9 870.7 924.3 953.6 961.4 12939.4 14435.2 14786.8 15572.7 16052.4 746.8 851.3 855.2 859.7 863.3 8683.7 8688.5 8740.8 8934.6 8949.6 478218.0 480796.0 484290.0 499336.0 505350.0 67887.7 69630.3 70337.3 71215.0 71381.0 1098.4 1101.5 1109.7 1130.7 1138.6 13780.7 13841.3 13936.4 14058.8 14184.8 30150.8 30467.5 31369.7 31399.7 31861.2 41912.8 42085.8 42434.2 42859.6 43434.8 8896.4 8911.9 8940.3 9020.8 9077.5 10439.2 10486.0 10554.3 10635.4 14842.6 13446.2 13470.0 13682.2 13717.8 13887.7 13123.1 13131.5 13195.9 13724.7 13802.0 12898.5 12915.4 13128.5 13251.3 13748.0 7587.3 7631.6 7749.2 8062.3 8850.2 9533.8 13323.3 13590.8 13959.8 14201.7 16:45:55 INFO - 2015-11-20 16:45:55,907 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,907 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4666.13 Median:5774.97 stddev:2314.22 (40.1%) stddev-sans-first:2307.45 16:45:55 INFO - 2015-11-20 16:45:55,907 DEBUG : BROWSER_OUTPUT: Values: 1369.7 1426.3 1519.0 1593.9 1705.7 5616.3 5726.5 6458.2 6812.0 6813.8 5904.4 6512.3 6731.9 6749.5 6755.8 2014.1 2080.1 2085.1 2086.4 2091.4 1746.4 1794.2 2028.4 2078.3 2083.5 2042.4 2047.2 2052.1 2053.4 2054.4 1994.4 2019.8 2040.0 2040.8 2040.9 2062.0 2080.1 2091.9 2106.8 2108.8 6373.3 6413.4 6419.5 6423.4 6426.2 3992.0 4071.1 4072.5 4085.8 4092.8 2693.8 2725.7 2773.8 2775.4 2798.5 815.4 843.7 865.2 872.9 876.6 8888.1 8891.8 8913.8 8925.7 8933.0 3782.9 3819.5 3855.2 3878.2 3942.1 7714.6 7734.0 7739.4 7751.4 7754.3 4109.6 4118.3 4122.9 4123.3 4130.5 3724.3 3738.8 3746.9 3753.4 3761.6 3359.6 3370.3 3379.6 3381.4 3414.4 875.5 968.6 1035.3 1100.7 1130.7 897.1 898.9 968.3 1056.2 1168.7 6420.1 6467.7 6477.4 6493.6 6498.1 1018.2 1027.8 1032.4 1033.2 1068.3 4808.8 4878.0 4912.5 4918.8 4921.6 7498.9 7558.9 7634.2 7651.6 7678.8 7618.3 7665.7 7668.6 7684.8 7698.9 6091.9 6163.3 6200.1 6202.1 6212.8 5685.1 5773.9 5776.0 5780.6 5786.2 6762.4 6791.9 6898.3 6971.1 6997.2 6999.6 7005.7 7072.6 7083.0 7194.3 6051.1 6129.8 6134.0 6134.4 6146.6 6419.1 6444.5 6473.3 6478.7 6482.3 5337.7 5474.3 5980.2 6061.9 6214.6 5884.0 5930.4 6102.8 6117.1 6127.6 6159.8 6188.4 6202.0 6202.3 6207.6 5656.1 5697.0 5701.0 5710.3 5719.2 5697.9 5716.5 5741.6 5743.1 5764.7 16:45:55 INFO - 2015-11-20 16:45:55,908 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,908 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4706.60 Median:5369.03 stddev:1375.79 (25.6%) stddev-sans-first:1339.55 16:45:55 INFO - 2015-11-20 16:45:55,909 DEBUG : BROWSER_OUTPUT: Values: 313.4 318.5 319.1 320.3 320.7 5366.7 5392.7 5410.4 5430.2 5444.0 5121.8 5176.9 5236.0 5314.7 5371.3 4191.8 4210.1 4216.3 4221.3 4227.8 3991.8 4195.3 4216.0 4222.7 4231.1 4045.1 4054.2 4120.0 4121.6 4144.6 4139.2 4151.4 4170.2 4183.3 4192.6 3683.3 3686.3 3687.9 3690.1 3690.3 5120.4 5140.9 5147.6 5152.7 5154.6 4645.2 4751.2 4757.2 4768.4 4823.9 5616.2 5680.1 5689.8 5691.2 5691.5 3962.6 3968.7 3970.0 3970.6 3972.2 5851.8 5946.9 5956.6 5959.4 5963.3 3945.5 4087.9 4091.5 4095.6 4105.4 4139.9 4147.3 4147.8 4155.1 4170.7 4765.4 4775.7 4778.7 4785.0 4787.5 5682.6 5685.7 5685.9 5699.0 5699.1 1423.1 1448.5 1463.8 1464.0 1465.0 961.7 990.9 991.5 993.5 1002.3 4876.9 4894.0 4894.5 4898.5 4899.0 5771.9 5774.6 5797.9 5803.1 5804.4 4801.1 4895.2 4895.5 4936.1 5018.0 3165.5 3176.3 3189.4 3203.6 3204.3 5585.4 5586.4 5586.9 5589.1 5589.9 5887.2 6048.8 6068.5 6068.5 6080.6 5593.9 5601.2 5613.8 5614.5 5615.6 5915.2 5929.5 5931.0 5934.5 5941.6 5779.4 5787.8 5790.9 5792.1 5802.4 5443.1 5591.0 5618.1 5621.0 5621.1 4191.3 4229.6 4240.7 4242.6 4251.7 5881.2 5891.9 5894.4 5896.6 5898.3 5532.8 5653.9 5662.3 5663.3 5667.7 5648.4 5650.2 5653.0 5657.2 5659.7 5530.5 5544.2 5544.3 5547.3 5549.0 5660.4 5683.3 5684.1 5692.0 5696.8 5469.8 5610.4 5612.6 5616.0 5622.1 16:45:55 INFO - 2015-11-20 16:45:55,909 DEBUG : BROWSER_OUTPUT: 16:45:55 INFO - 2015-11-20 16:45:55,909 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12518.94 Median:45747.89 stddev:14288.20 (31.2%) stddev-sans-first:14300.39 16:45:55 INFO - 2015-11-20 16:45:55,909 DEBUG : BROWSER_OUTPUT: Values: 631.0 673.6 684.8 724.7 734.3 11155.4 11369.2 11373.5 12693.7 12874.5 14069.9 14149.4 14163.7 14177.1 14179.1 620.3 626.9 789.2 790.7 804.0 795.2 798.2 799.8 804.9 805.0 654.3 832.9 840.8 841.1 842.1 658.6 825.1 832.9 834.2 839.5 616.7 618.0 618.0 618.1 618.2 11119.5 11151.9 11173.5 11199.0 11208.2 10717.9 11135.7 11158.8 11402.4 11812.9 8972.1 9000.5 9011.9 9216.3 9437.2 3159.3 3161.4 3189.6 3225.6 3234.9 42923.4 43338.6 43340.1 43428.6 43453.6 8633.3 8760.9 8786.2 8791.0 8914.8 16483.2 16554.1 16586.7 16591.2 16595.4 6338.1 6414.0 6491.5 6606.9 6621.3 3578.9 3613.6 3614.3 3627.7 3635.8 2661.3 2697.7 2704.3 2709.4 2711.9 469.9 475.0 479.4 482.7 483.9 497.2 572.6 602.5 610.5 641.0 7433.8 7855.2 7867.4 7962.2 8085.2 506.6 542.4 592.5 603.6 608.9 3624.6 3703.5 3722.0 3800.3 3834.6 49194.8 50206.0 50487.2 51152.7 51261.0 44228.6 44847.1 45074.5 45395.8 46100.0 41894.6 41960.4 42748.6 42922.0 43291.4 7224.7 7370.2 8064.7 8251.5 8461.2 30546.4 31506.8 31517.0 31780.4 33429.7 40723.6 40755.2 40953.2 40955.2 41622.0 9454.5 9761.9 9905.8 10037.7 10110.7 11423.7 11425.1 11540.6 11585.4 11630.8 10043.2 10133.4 10212.6 10280.6 11013.2 10687.5 11005.1 11120.6 11263.4 11274.3 10406.5 10891.4 10920.9 11001.8 11250.3 9071.1 9217.9 9337.4 9417.9 9811.5 8850.9 8870.2 8952.8 9063.9 9175.1 16:45:55 INFO - 2015-11-20 16:45:55,909 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:45:55 INFO - 2015-11-20 16:45:55,910 DEBUG : BROWSER_OUTPUT: 16:45:56 INFO - 2015-11-20 16:45:56,669 INFO : Browser exited with error code: 0 16:45:56 INFO - 2015-11-20 16:45:56,693 INFO : Completed test dromaeo_css (00:18:37) 16:45:56 INFO - 2015-11-20 16:45:56,693 INFO : Starting test kraken 16:45:56 INFO - 2015-11-20 16:45:56,693 DEBUG : operating with platform_type : linux_ 16:45:56 INFO - 2015-11-20 16:45:56,693 INFO : Initialising browser for kraken test... 16:45:56 INFO - 2015-11-20 16:45:56,699 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgY9nj/profile http://localhost:56683/getInfo.html 16:46:00 INFO - 2015-11-20 16:46:00,431 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:46:00 INFO - 2015-11-20 16:46:00,431 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:46:00 INFO - 2015-11-20 16:46:00,431 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:46:00 INFO - 2015-11-20 16:46:00,431 DEBUG : BROWSER_OUTPUT: __metrics 16:46:00 INFO - 2015-11-20 16:46:00,548 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:01 INFO - 2015-11-20 16:46:01,818 INFO : Browser initialized. 16:46:01 INFO - 2015-11-20 16:46:01,818 INFO : Running cycle 1/1 for kraken test... 16:46:01 INFO - 2015-11-20 16:46:01,818 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgY9nj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:46:13 INFO - 2015-11-20 16:46:13,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 141901824 16:46:13 INFO - 2015-11-20 16:46:13,737 DEBUG : BROWSER_OUTPUT: 16:46:16 INFO - 2015-11-20 16:46:16,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56683/tests/kraken/driver.html?testName=audio-beat-detection) 16:46:16 INFO - 2015-11-20 16:46:16,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 178237440 16:46:16 INFO - 2015-11-20 16:46:16,961 DEBUG : BROWSER_OUTPUT: 16:46:19 INFO - 2015-11-20 16:46:19,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56683/tests/kraken/driver.html?testName=audio-dft) 16:46:20 INFO - 2015-11-20 16:46:20,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 168206336 16:46:20 INFO - 2015-11-20 16:46:20,206 DEBUG : BROWSER_OUTPUT: 16:46:23 INFO - 2015-11-20 16:46:23,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56683/tests/kraken/driver.html?testName=audio-fft) 16:46:23 INFO - 2015-11-20 16:46:23,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 151474176 16:46:23 INFO - 2015-11-20 16:46:23,792 DEBUG : BROWSER_OUTPUT: 16:46:25 INFO - 2015-11-20 16:46:25,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56683/tests/kraken/driver.html?testName=audio-oscillator) 16:46:26 INFO - 2015-11-20 16:46:26,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 153993216 16:46:26 INFO - 2015-11-20 16:46:26,406 DEBUG : BROWSER_OUTPUT: 16:46:28 INFO - 2015-11-20 16:46:28,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:46:29 INFO - 2015-11-20 16:46:29,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 155340800 16:46:29 INFO - 2015-11-20 16:46:29,173 DEBUG : BROWSER_OUTPUT: 16:46:32 INFO - 2015-11-20 16:46:32,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56683/tests/kraken/driver.html?testName=imaging-darkroom) 16:46:32 INFO - 2015-11-20 16:46:32,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 156438528 16:46:32 INFO - 2015-11-20 16:46:32,691 DEBUG : BROWSER_OUTPUT: 16:46:36 INFO - 2015-11-20 16:46:36,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56683/tests/kraken/driver.html?testName=imaging-desaturate) 16:46:36 INFO - 2015-11-20 16:46:36,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 158171136 16:46:36 INFO - 2015-11-20 16:46:36,743 DEBUG : BROWSER_OUTPUT: 16:46:39 INFO - 2015-11-20 16:46:39,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56683/tests/kraken/driver.html?testName=json-parse-financial) 16:46:40 INFO - 2015-11-20 16:46:40,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 156966912 16:46:40 INFO - 2015-11-20 16:46:40,149 DEBUG : BROWSER_OUTPUT: 16:46:41 INFO - 2015-11-20 16:46:41,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:46:42 INFO - 2015-11-20 16:46:42,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 165556224 16:46:42 INFO - 2015-11-20 16:46:42,448 DEBUG : BROWSER_OUTPUT: 16:46:44 INFO - 2015-11-20 16:46:44,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:46:44 INFO - 2015-11-20 16:46:44,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 162697216 16:46:44 INFO - 2015-11-20 16:46:44,941 DEBUG : BROWSER_OUTPUT: 16:46:47 INFO - 2015-11-20 16:46:47,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:46:47 INFO - 2015-11-20 16:46:47,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 168214528 16:46:47 INFO - 2015-11-20 16:46:47,620 DEBUG : BROWSER_OUTPUT: 16:46:50 INFO - 2015-11-20 16:46:50,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:46:50 INFO - 2015-11-20 16:46:50,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 177348608 16:46:50 INFO - 2015-11-20 16:46:50,701 DEBUG : BROWSER_OUTPUT: 16:46:53 INFO - 2015-11-20 16:46:53,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:46:53 INFO - 2015-11-20 16:46:53,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 175071232 16:46:53 INFO - 2015-11-20 16:46:53,865 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56683/tests/kraken/driver.html?testName=ai-astar) 16:46:55 INFO - 2015-11-20 16:46:55,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 233570304 16:46:55 INFO - 2015-11-20 16:46:55,844 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,847 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:46:55 INFO - 2015-11-20 16:46:55,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:46:55 INFO - 2015-11-20 16:46:55,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:46:55 INFO - 2015-11-20 16:46:55,847 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;111;111;112;100;111;115;111 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;133;151;167;130;153;151;131;164;132 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;162;160;160;161;164;163;163;161 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;84;88;72;73;73;107;92;73 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;123;91;92;92;130;91;91;132 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;109;109;109;110;109 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;146;147;148;147;146;147 16:46:55 INFO - 2015-11-20 16:46:55,848 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;103;96;95;95;96;96;96 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;71;69;71;69;79;68;69 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;69;69;70;68;68;68 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;82;81;88;82;81;83;82;81 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;127;120;138;120;120;120;127;129 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;136;147;152;160;137;146;145;144;134 16:46:55 INFO - 2015-11-20 16:46:55,849 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;68;68;70;68;69;69;69 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066815845__endTimestamp 16:46:55 INFO - 2015-11-20 16:46:55,850 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,854 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:46:55 INFO - 2015-11-20 16:46:55,854 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:46:55 INFO - 2015-11-20 16:46:55,854 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,854 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.37 16:46:55 INFO - 2015-11-20 16:46:55,854 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 111.0 111.0 112.0 100.0 111.0 115.0 111.0 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.00 stddev:14.03 (9.2%) stddev-sans-first:14.62 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: Values: 154.0 133.0 151.0 167.0 130.0 153.0 151.0 131.0 164.0 132.0 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.41 16:46:55 INFO - 2015-11-20 16:46:55,855 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 162.0 160.0 160.0 161.0 164.0 163.0 163.0 161.0 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:11.68 (15.8%) stddev-sans-first:12.03 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 84.0 88.0 72.0 73.0 73.0 107.0 92.0 73.0 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:91.00 stddev:18.11 (19.9%) stddev-sans-first:18.65 16:46:55 INFO - 2015-11-20 16:46:55,856 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 123.0 91.0 92.0 92.0 130.0 91.0 91.0 132.0 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.50 stddev:2.44 (2.6%) stddev-sans-first:2.55 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 103.0 96.0 95.0 95.0 96.0 96.0 96.0 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:3.09 (4.4%) stddev-sans-first:3.27 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 71.0 69.0 71.0 69.0 79.0 68.0 69.0 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,858 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 69.0 69.0 70.0 68.0 68.0 68.0 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.12 (2.6%) stddev-sans-first:2.19 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 82.0 81.0 88.0 82.0 81.0 83.0 82.0 81.0 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:5.83 (4.6%) stddev-sans-first:6.14 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 127.0 120.0 138.0 120.0 120.0 120.0 127.0 129.0 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:145.50 stddev:7.91 (5.4%) stddev-sans-first:8.25 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: Values: 140.0 136.0 147.0 152.0 160.0 137.0 146.0 145.0 144.0 134.0 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 68.0 70.0 68.0 69.0 69.0 69.0 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:46:55 INFO - 2015-11-20 16:46:55,859 DEBUG : BROWSER_OUTPUT: 16:46:56 INFO - 2015-11-20 16:46:56,805 INFO : Browser exited with error code: 0 16:46:56 INFO - 2015-11-20 16:46:56,855 INFO : Completed test kraken (00:01:00) 16:46:56 INFO - 2015-11-20 16:46:56,855 INFO : Starting test v8_7 16:46:56 INFO - 2015-11-20 16:46:56,855 DEBUG : operating with platform_type : linux_ 16:46:56 INFO - 2015-11-20 16:46:56,856 INFO : Initialising browser for v8_7 test... 16:46:56 INFO - 2015-11-20 16:46:56,862 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcv0TQw/profile http://localhost:56683/getInfo.html 16:47:00 INFO - 2015-11-20 16:47:00,598 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:47:00 INFO - 2015-11-20 16:47:00,598 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:47:00 INFO - 2015-11-20 16:47:00,598 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:47:00 INFO - 2015-11-20 16:47:00,598 DEBUG : BROWSER_OUTPUT: __metrics 16:47:00 INFO - 2015-11-20 16:47:00,755 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:47:02 INFO - 2015-11-20 16:47:02,030 INFO : Browser initialized. 16:47:02 INFO - 2015-11-20 16:47:02,031 INFO : Running cycle 1/1 for v8_7 test... 16:47:02 INFO - 2015-11-20 16:47:02,031 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcv0TQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:47:13 INFO - 2015-11-20 16:47:13,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 141893632 16:47:13 INFO - 2015-11-20 16:47:13,922 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56683/tests/v8_7/run.html (next: http://localhost:56683/tests/v8_7/run.html) 16:47:35 INFO - 2015-11-20 16:47:35,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 442535936 16:47:35 INFO - 2015-11-20 16:47:35,583 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,585 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:47:35 INFO - 2015-11-20 16:47:35,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:47:35 INFO - 2015-11-20 16:47:35,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:47:35 INFO - 2015-11-20 16:47:35,585 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3453119895459 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.75455417066155 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 16:47:35 INFO - 2015-11-20 16:47:35,586 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: |8;Splay;618.0469715698393 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066855584__endTimestamp 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,587 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:47:35 INFO - 2015-11-20 16:47:35,588 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:47:35 INFO - 2015-11-20 16:47:35,588 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,588 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.35 Median:163.35 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,588 DEBUG : BROWSER_OUTPUT: Values: 163.3 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.75 Median:191.75 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: Values: 191.8 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: Values: 279.4 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: Values: 5030.2 16:47:35 INFO - 2015-11-20 16:47:35,589 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,590 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: Values: 1978.3 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: Values: 788.0 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: Values: 12345.7 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: Values: 26500.0 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.05 Median:618.05 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: Values: 618.0 16:47:35 INFO - 2015-11-20 16:47:35,591 DEBUG : BROWSER_OUTPUT: 16:47:35 INFO - 2015-11-20 16:47:35,592 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:47:35 INFO - 2015-11-20 16:47:35,592 DEBUG : BROWSER_OUTPUT: Values: 4826.9 16:47:35 INFO - 2015-11-20 16:47:35,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:47:35 INFO - 2015-11-20 16:47:35,592 DEBUG : BROWSER_OUTPUT: 16:47:36 INFO - 2015-11-20 16:47:36,537 INFO : Browser exited with error code: 0 16:47:36 INFO - 2015-11-20 16:47:36,552 INFO : Completed test v8_7 (00:00:39) 16:47:36 INFO - 2015-11-20 16:47:36,606 INFO : Completed test suite (00:20:17) 16:47:36 INFO - 2015-11-20 16:47:36,606 DEBUG : Working with test: dromaeo_css 16:47:36 INFO - 2015-11-20 16:47:36,606 DEBUG : Generating results file: dromaeo_css 16:47:36 INFO - 2015-11-20 16:47:36,607 DEBUG : Working with test: kraken 16:47:36 INFO - 2015-11-20 16:47:36,607 DEBUG : Generating results file: kraken 16:47:36 INFO - 2015-11-20 16:47:36,607 INFO : javascript benchmark 16:47:36 INFO - 2015-11-20 16:47:36,608 DEBUG : Working with test: v8_7 16:47:36 INFO - 2015-11-20 16:47:36,608 DEBUG : Generating results file: v8_7 16:47:36 INFO - 2015-11-20 16:47:36,608 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:47:36 INFO - 2015-11-20 16:47:36,663 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 16:47:36 INFO - 2015-11-20 16:47:36,663 DEBUG : process_Request line: dromaeo_css 6291.85 graph.html#tests=[[72,203,35]] 16:47:36 INFO - 2015-11-20 16:47:36,664 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:47:36 INFO - 2015-11-20 16:47:36,695 DEBUG : process_Request line: kraken 1513.30 graph.html#tests=[[232,203,35]] 16:47:36 INFO - 2015-11-20 16:47:36,695 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:47:36 INFO - 2015-11-20 16:47:36,725 DEBUG : process_Request line: v8_7 19806.72 graph.html#tests=[[230,203,35]] 16:47:36 INFO - 2015-11-20 16:47:36,726 INFO : javascript benchmark 16:47:36 INFO - 2015-11-20 16:47:36,730 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2653.9734602653975, 2725.904593339232, 2731.8360898346114, 2742.7531522163013, 2757.600147978543, 4477.08219814938, 4613.377194078798, 4660.743659098753, 4713.010267843752, 4720.291956206575, 4617.353570500132, 4636.2581986882105, 4733.881652958669, 4737.455192652846, 4748.169070412672, 4352.281873490886, 4355.825766969318, 4376.97811510942, 4392.736435813846, 4412.97793511032, 4216.3464662977285, 4399.142167277382, 4408.4709834819705, 4447.510773814878, 4460.442444694413, 4219.38818871262, 4298.075913678543, 4304.80628371724, 4319.654427645781, 4323.265044942336, 4343.717658352197, 4345.174416860787, 4345.1961387143165, 4351.325544540601, 4388.868333949955, 4102.261592913274, 4320.416743739586, 4324.113556720896, 4334.9783251083545, 4373.912521749579, 4466.419365482499, 4506.324051392285, 4550.226461501553, 4645.907081858344, 4680.9297860532115, 5061.620378471629, 5099.107656160194, 5104.25988231708, 5105.132127538291, 5148.0, 4841.055994081155, 5133.25567792668, 5140.794368225266, 5147.639665223436, 5154.716490593016, 4581.9541804582195, 4582.725036497821, 4603.631709463235, 4617.907641847144, 4690.953090469052, 5171.224316352502, 5187.221916712448, 5187.559057480156, 5190.377154741455, 5236.240745092016, 4666.1834179019215, 4965.751712414365, 4971.90056198874, 4973.701577905337, 5023.547880690755, 4935.136351138536, 4940.6788558743565, 4968.428630707443, 5038.34501514808, 5063.215201643751, 4952.331435256267, 4970.428400733889, 4976.328195693607, 4984.22744474607, 5019.67372120811, 4736.029114031615, 4931.3835770528685, 4935.136351138536, 4947.158982972904, 4989.326440930428, 4099.631033206966, 4108.897277568085, 4119.320312148462, 4162.375643653476, 4163.167366526707, 3636.581793093775, 3643.216708407705, 3656.524651795303, 3679.2089700714473, 3683.4106542953537, 4317.740935543878, 4340.934885976713, 4345.044090300129, 4350.434443522322, 4378.036831896978, 4760.119377915097, 4936.531029552187, 4939.827106051271, 4940.308356830046, 4941.851744447672, 4364.8254069837485, 4367.170237654836, 4373.453318335208, 4388.802503887333, 4403.427554417905, 4488.371627972087, 4491.483479399845, 4492.213862574036, 4493.281075028045, 4528.592426681615, 4541.091781643619, 4655.883602909955, 4658.417697787777, 4795.184818580849, 4802.615790736662, 4955.132851750857, 5037.0, 5039.118154323052, 5040.14317566022, 5088.236764485357, 4808.302796094476, 4851.054044461296, 4879.536444037811, 4883.194272944925, 4919.0899683558655, 4791.592714619296, 4891.559759621651, 4901.215805471107, 5036.974815125901, 5120.795168193231, 4997.800087996439, 5075.314832497713, 5077.136886729339, 5095.388553373619, 5106.46382129871, 4875.975620122019, 4877.9024419512125, 4883.413990321184, 4885.609151267961, 4926.802927882844, 4647.62818974488, 4760.59534939534, 4881.194602890483, 4882.2432522959, 4929.482404347492, 4715.3869996900185, 4758.500357462555, 4867.075255701406, 4869.610431165569, 4877.024595081069, 4960.255961605788, 4974.403071631427, 4999.750012499288, 5008.373953255843, 5014.07239660664, 4866.513348665247, 4872.805087796591, 4904.558589726942, 4916.508349165055, 4955.40535135786], "unit": "ms", "name": "dojo.html", "value": 4608.931859182385}, {"lowerIsBetter": false, "replicates": [562.1343131577371, 566.9603127781056, 568.9630174038687, 579.6290374160538, 591.9911201331978, 28108.859455702717, 28756.712432875665, 36883.81558092209, 37704.05739856505, 37907.0, 40062.596244225366, 40363.192736145334, 40363.79818100906, 40487.79756101223, 40495.59504404955, 7028.753993610225, 7870.881936770938, 8058.476199047072, 8072.475289106219, 8130.349572034253, 7102.289771022883, 9924.354916930413, 10079.0, 10116.241281903849, 10116.393016419039, 10199.490025498733, 10302.7424314392, 10303.330283531546, 10303.742406439824, 10319.0, 7222.711091556332, 7418.814529636748, 10023.148032417253, 10126.44304563245, 10177.0, 9770.0, 9890.703278901645, 9891.20870330379, 9894.10953014225, 9903.950480247624, 37440.87677369683, 37791.43312850309, 37877.0, 37886.43170352447, 37987.0, 2732.27594687408, 2862.1413575927345, 2868.1969048666406, 3144.68553144686, 3365.612954510238, 28644.0, 28650.283742906384, 28774.136775896757, 28849.71150288491, 29476.26309342262, 3389.389909816232, 3554.8578056877695, 3565.322588708137, 3579.3020361029608, 3682.355587772156, 226502.0, 228496.0, 229023.0, 229418.0, 230527.0, 52500.73749631227, 53484.73257633687, 53498.46501535013, 56844.431555683914, 57359.713201433726, 48883.75558122258, 61907.690461547405, 62422.0, 63014.68492657507, 63061.0, 12915.612531624067, 12918.547850825176, 12985.350732463528, 13021.153625014344, 13095.0, 9192.63229470827, 9196.954015229881, 9202.171804537624, 9207.309451791143, 9225.446473211628, 19363.224171286463, 19581.902090489457, 19734.0, 19734.901325493567, 19848.90075549642, 7809.180036096242, 8107.135358867494, 8117.837643247102, 8120.309773669304, 8134.105248422668, 818.8607936650784, 837.7486753973783, 950.4819873169139, 955.6416343871049, 967.0619499085875, 26446.0, 26729.465410692068, 30648.0, 31487.37025259482, 31676.0, 930.9162175404247, 944.730751735752, 1023.744063984004, 1078.7087486378791, 1101.3502033800096, 13807.240601766798, 13963.930180349033, 14057.367418466194, 14133.71732565343, 14158.433662653379, 317713.0, 319902.0, 322032.0, 322068.0, 322875.0, 43790.34314485285, 44721.10557788826, 48266.0, 48301.275480867815, 48996.0, 1185.9187126592947, 1223.3088305107763, 1227.7483115961206, 1232.8582213045436, 1237.0845574275152, 28225.576616351183, 28734.568981465713, 29224.853875731336, 29495.410091798472, 29570.0, 33894.15264618404, 34559.13602159966, 39698.40452393159, 40381.192376151725, 41485.377719334836, 194858.0, 195199.0, 195978.0, 196265.0, 196887.0, 28492.287692807844, 28839.7116028837, 28892.277693057, 28971.85514072416, 28973.420531589672, 36463.45304820483, 37486.0, 37953.62046379611, 42818.148431218746, 44103.33844992392, 34825.65174348224, 35987.95949286345, 36029.0, 36508.26983460369, 37024.0, 35867.28265434624, 35882.82058589795, 36580.45129323009, 36781.816090920445, 36983.815080924425, 35202.823985879906, 35991.82004089963, 36210.637893620726, 36253.0, 36265.637343627284, 32560.18599534936, 32808.88546918061, 33034.504482432305, 33050.22082775439, 33464.83267583744, 25104.246872593852, 25225.87387063053, 25365.61951570691, 25403.491930161665, 25973.740262597134], "unit": "ms", "name": "ext.html", "value": 17533.700492222306}, {"lowerIsBetter": false, "replicates": [336.9595648522178, 340.59639327397036, 340.6661471757677, 341.43833394066746, 342.33074339665956, 12311.015118790498, 12875.0, 15182.772258416118, 15303.464378746732, 17352.0, 13832.861671383283, 14352.641183970405, 14861.92569037156, 15202.619934501643, 15297.923510382432, 4980.750962451881, 5022.673526220784, 5125.333706618153, 5199.714015729133, 5214.843554693346, 3339.6159441664154, 3460.359833430811, 5163.096458119833, 5217.191335343028, 5394.05604019297, 5321.148616221405, 5339.439358867321, 5373.032854086263, 5387.488188622095, 5391.218273350361, 4936.308916751657, 5335.146376579748, 5432.293801805779, 5436.994156081138, 5440.102383106782, 5216.895662086775, 5232.895342093175, 5234.842954711365, 5239.973800131013, 5241.842744717626, 12242.143049986504, 15506.61233469161, 17911.641767164583, 18888.05559722022, 18901.243950241973, 1675.2126500544725, 1784.5092599535233, 1803.431918945528, 1919.0255104587973, 1926.2969016309087, 8757.605907734167, 8977.596008179647, 9049.0, 9073.81852362949, 11182.105431565455, 1683.267778516337, 1695.93216271349, 1734.2369357482794, 1756.7628370169991, 1780.9910950445164, 48800.75599621979, 51216.487835121916, 53044.0, 57020.714896425256, 59509.404905951254, 9500.287478439144, 9531.428114313025, 9583.712488625353, 9649.228061755042, 9914.801703966024, 11855.0, 11891.037978733586, 11897.34564598938, 11901.583444579399, 11904.404779760976, 6646.836803559455, 6661.4004739573675, 6667.266600673922, 6704.497162712816, 6723.159605049369, 6300.27546832111, 6308.243010838729, 6326.145970293951, 6343.555951083472, 6345.143405640272, 3949.289127956938, 4075.5109386873764, 4211.578842115825, 4242.5121111072, 4246.936295955563, 1615.830337814536, 1652.9504114876572, 1669.7495375693743, 1674.0792564089702, 1678.337056862557, 796.8525822722814, 870.656090844113, 924.306769922558, 953.5804246131819, 961.3606951377255, 12939.353032348345, 14435.206063666388, 14786.778198327034, 15572.688546229012, 16052.357905683642, 746.8356961468468, 851.2551517422255, 855.2302927365421, 859.657433493737, 863.3179787967435, 8683.696070637623, 8688.478691278544, 8740.825183496294, 8934.553272336487, 8949.552522373855, 478218.0, 480796.0, 484290.0, 499336.0, 505350.0, 67887.66056169687, 69630.3036969634, 70337.2966270341, 71215.0, 71381.0, 1098.368438148052, 1101.509828126492, 1109.6837401340579, 1130.7342774447998, 1138.573035111833, 13780.65548361299, 13841.30793460343, 13936.372863221382, 14058.78911816344, 14184.787228191792, 30150.849245754507, 30467.542986854773, 31369.686303136677, 31399.686003139675, 31861.20346991344, 41912.790436047624, 42085.78957105195, 42434.15131697411, 42859.571404286806, 43434.78282608567, 8896.377253592187, 8911.880841705351, 8940.329475289509, 9020.774480638036, 9077.500737459502, 10439.164866810788, 10486.0, 10554.261201715806, 10635.415052172204, 14842.554723358317, 13446.193228406328, 13470.0, 13682.247476388497, 13717.794233086712, 13887.652808679459, 13123.146995445266, 13131.474741010252, 13195.868041319463, 13724.725505490034, 13802.033857629869, 12898.48406063747, 12915.418806153933, 13128.540501082416, 13251.271180085188, 13748.0, 7587.317141457295, 7631.580263085583, 7749.225077492206, 8062.274395304451, 8850.20348168668, 9533.809323813346, 13323.267220302589, 13590.79613805774, 13959.790603141164, 14201.715965680834], "unit": "ms", "name": "jquery.html", "value": 8043.19099274809}, {"lowerIsBetter": false, "replicates": [1369.7329020840934, 1426.3153686230612, 1518.9772153417694, 1593.9400298801297, 1705.7356109802977, 5616.32604087509, 5726.541876649869, 6458.160439142911, 6812.046313516112, 6813.829654258646, 5904.350521442638, 6512.283648798629, 6731.899021514681, 6749.49378796591, 6755.797326080213, 2014.0936578539643, 2080.115950720945, 2085.082563671987, 2086.405374468277, 2091.4144039668918, 1746.4498682914905, 1794.2374490841405, 2028.4117605894273, 2078.282992367631, 2083.4583008417767, 2042.3566576528347, 2047.2322878920404, 2052.0663098290242, 2053.37372101509, 2054.352878843167, 1994.3917105282883, 2019.798020197983, 2040.0411806450945, 2040.8265297449586, 2040.9489762755902, 2061.989690051555, 2080.095158605996, 2091.9477013074793, 2106.820920221783, 2108.8312934965165, 6373.330800265951, 6413.422791948747, 6419.486441084702, 6423.389777971085, 6426.164598602152, 3991.980040099781, 4071.124708187724, 4072.5112986441522, 4085.775282359469, 4092.8158232879296, 2693.7575618194455, 2725.74105459981, 2773.791965602568, 2775.417162395899, 2798.5242508773354, 815.4251252866715, 843.7342237195264, 865.2126564826041, 872.8603423452217, 876.6055275126218, 8888.111188881125, 8891.822163556757, 8913.821723565492, 8925.687600933936, 8932.955335223347, 3782.867599634, 3819.503464549646, 3855.151866589346, 3878.2243551289853, 3942.0539070623418, 7714.614269286513, 7734.03324584427, 7739.380849532024, 7751.379889608817, 7754.263344982218, 4109.568495308009, 4118.320477121301, 4122.876313710593, 4123.340265557496, 4130.463039804806, 3724.273766615538, 3738.813059347022, 3746.8501259949844, 3753.3994560870674, 3761.586225515191, 3359.5800524934384, 3370.292238629915, 3379.5775528058994, 3381.408253555618, 3414.4195486767308, 875.5403413208116, 968.6319198704447, 1035.2597892506894, 1100.7028102412303, 1130.7173206698326, 897.0580890065405, 898.8876390451194, 968.3028219681818, 1056.2236755984345, 1168.7428765671539, 6420.133282006869, 6467.741290348427, 6477.4494167996245, 6493.577917435352, 6498.122753428322, 1018.2363227579316, 1027.814993301198, 1032.3599368391644, 1033.188946676855, 1068.3376306689747, 4808.783604737795, 4878.0, 4912.508749125131, 4918.803247870045, 4921.557059864558, 7498.925010749932, 7558.886616700754, 7634.236576342432, 7651.617419129021, 7678.846423071507, 7618.276263754934, 7665.731699390494, 7668.616569171519, 7684.846303073908, 7698.884516732253, 6091.939080609226, 6163.322034576193, 6200.131981522591, 6202.100695399142, 6212.844678883064, 5685.061964775766, 5773.884522309446, 5776.046952252831, 5780.5953583248765, 5786.247787787561, 6762.357576030269, 6791.89812152828, 6898.310168983062, 6971.093757811452, 6997.195322537769, 6999.580025198505, 7005.684744186422, 7072.646367681698, 7083.043789088407, 7194.280571942764, 6051.12258722474, 6129.816105516842, 6133.969330153499, 6134.35589263121, 6146.631202127886, 6419.133416988833, 6444.484441244783, 6473.255575608677, 6478.708458119301, 6482.319356467691, 5337.6797392156595, 5474.288342515448, 5980.222571065734, 6061.939380606137, 6214.5960512568345, 5883.970580147072, 5930.377310382348, 6102.847428814315, 6117.0824376342125, 6127.632342059491, 6159.81520554384, 6188.44304012641, 6201.96899015502, 6202.255729312511, 6207.565470417027, 5656.123300888369, 5696.971515142398, 5700.971495142498, 5710.257666503494, 5719.170720245625, 5697.898079991167, 5716.514096301861, 5741.598355580838, 5743.0811070228565, 5764.654120752768], "unit": "ms", "name": "mootools.html", "value": 3892.150536899115}, {"lowerIsBetter": false, "replicates": [313.39671133068845, 318.5317583152765, 319.1192309226534, 320.34009939524566, 320.7321886225002, 5366.731663416828, 5392.7303634818245, 5410.404855465896, 5430.185472179165, 5444.047291723942, 5121.8463446096675, 5176.870578235536, 5236.031334203175, 5314.671332166959, 5371.328583927009, 4191.811368488426, 4210.073783767566, 4216.3464662977285, 4221.26127927613, 4227.8097485613225, 3991.7604943703473, 4195.328747400416, 4216.0, 4222.704410691253, 4231.090315582149, 4045.0898547826796, 4054.2499637567, 4119.958800411988, 4121.5672354402805, 4144.606262405066, 4139.2135494256145, 4151.356539736345, 4170.16596680665, 4183.267928112568, 4192.601702838241, 3683.336999340118, 3686.318031164243, 3687.8893633191046, 3690.132818787583, 3690.335739566877, 5120.411152717448, 5140.948590514122, 5147.639665223436, 5152.742362881841, 5154.587632989352, 4645.187092258841, 4751.192297309466, 4757.191277482836, 4768.403949506312, 4823.927641085386, 5616.213730077751, 5680.0627896397045, 5689.772409103631, 5691.174779656926, 5691.51622112121, 3962.623550762673, 3968.6825053995613, 3969.9876531484574, 3970.602939706035, 3972.165845172517, 5851.76592936282, 5946.881062378771, 5956.55325850563, 5959.404059594092, 5963.344032156459, 3945.467361906106, 4087.9182416351505, 4091.5499295077516, 4095.6313931746286, 4105.44576482177, 4139.91720165595, 4147.294959856831, 4147.834086636561, 4155.10665206982, 4170.708050436501, 4765.356676848651, 4775.6657034007985, 4778.713277203379, 4785.0, 4787.521247875185, 5682.573806964411, 5685.715714214272, 5685.948099601587, 5699.002674532023, 5699.059655156935, 1423.1176670464379, 1448.4930274403873, 1463.7657974723993, 1464.0337377330911, 1464.985350146485, 961.7403301108661, 990.9405435673883, 991.4893829677721, 993.4635296939716, 1002.3484734922358, 4876.878078048077, 4893.95106048942, 4894.461609222983, 4898.461169271377, 4898.951010489921, 5771.913421298684, 5774.566907481955, 5797.913031304533, 5803.129530570448, 5804.419558044162, 4801.1117943180625, 4895.216765317603, 4895.461499235082, 4936.086823937583, 5018.04657115147, 3165.4776961801044, 3176.269458024667, 3189.3940151371166, 3203.583534140547, 3204.3110731192905, 5585.385607583163, 5586.35756887955, 5586.888262234733, 5589.105743081088, 5589.916151257735, 5887.2052272943465, 6048.818535443944, 6068.4538391544975, 6068.51451883857, 6080.604760690541, 5593.8601534961135, 5601.159826026129, 5613.803516876971, 5614.466625670555, 5615.578831587647, 5915.171875937458, 5929.466348028698, 5930.991731405585, 5934.465898069195, 5941.643501389931, 5779.364269930388, 5787.797427090031, 5790.913136302875, 5792.1311803229855, 5802.390748971297, 5443.074677304789, 5591.021571224938, 5618.101103823368, 5621.016322143527, 5621.100623900156, 4191.266528357464, 4229.640480559064, 4240.724352917051, 4242.639375653104, 4251.681123915657, 5881.206037185097, 5891.852703682271, 5894.381089985662, 5896.64620122794, 5898.262717160355, 5532.751026203911, 5653.858653533694, 5662.348829884616, 5663.348714897839, 5667.744951477111, 5648.350439699323, 5650.180723795109, 5653.0, 5657.179708942263, 5659.660420374791, 5530.474604912527, 5544.1960915667805, 5544.279243698294, 5547.251121098761, 5549.0289199389135, 5660.433956604306, 5683.261176047087, 5684.062129748545, 5691.971540142273, 5696.772129114789, 5469.808556700656, 5610.354809196831, 5612.579056570692, 5616.0, 5622.128570071482], "unit": "ms", "name": "prototype.html", "value": 4267.092164731388}, {"lowerIsBetter": false, "replicates": [630.9526785491089, 673.6126727131899, 684.780870121561, 724.6883839948822, 734.2804052029009, 11155.442227888603, 11369.204155709092, 11373.545058197673, 12693.682657933556, 12874.549390771324, 14069.92965035176, 14149.36327865246, 14163.716725665481, 14177.07848989815, 14179.078359906625, 620.3269452643887, 626.9059641053833, 789.1831953927687, 790.699534177012, 804.0, 795.2008231727107, 798.2057852436805, 799.7960520067375, 804.9154838741936, 805.0138580239219, 654.3325807676167, 832.862577674686, 840.794005468661, 841.1126261793805, 842.086336325088, 658.6245839871275, 825.0923983618032, 832.9333653307721, 834.2158371131118, 839.4795226959294, 616.7471336751955, 617.9969100154516, 618.001926888077, 618.1407843098098, 618.1562167641182, 11119.499622517005, 11151.888481115166, 11173.49719262627, 11199.0, 11208.15938804593, 10717.892821071768, 11135.665930022113, 11158.832617510743, 11402.429878506124, 11812.940935295355, 8972.147645973622, 9000.504972226525, 9011.909880901238, 9216.262698984065, 9437.150656440954, 3159.3207460396125, 3161.3835302116095, 3189.649138594753, 3225.645179030305, 3234.91912702182, 42923.35614965778, 43338.566614333766, 43340.13319733619, 43428.56571434309, 43453.565464345265, 8633.266172375294, 8760.912390876138, 8786.209241168326, 8791.0, 8914.777130571787, 16483.175841207893, 16554.089525076237, 16586.668266634842, 16591.170441477876, 16595.41916032933, 6338.080978258126, 6413.967930160413, 6491.545591808623, 6606.900896486556, 6621.33786621334, 3578.9284214315567, 3613.605333705416, 3614.313280476701, 3627.7460577759302, 3635.763675361093, 2661.321363052448, 2697.7167397422986, 2704.337437327867, 2709.43101948593, 2711.891524339044, 469.85904228731926, 475.028566581342, 479.4222961331587, 482.73932076678904, 483.90080033593733, 497.2044728434476, 572.6449601247253, 602.4818655955875, 610.5042349402362, 640.9839754006188, 7433.776986690408, 7855.175206603224, 7867.449278550446, 7962.203779621991, 8085.231902969209, 506.6402853973646, 542.395229319314, 592.4874983139639, 603.6217303822924, 608.9451949324493, 3624.637536246407, 3703.518542589446, 3722.013666378412, 3800.2969450651717, 3834.6357096075826, 49194.75402622964, 50206.0, 50487.24269135966, 51152.74423627932, 51261.0, 44228.557714422444, 44847.10305793931, 45074.54925450704, 45395.773021134686, 46100.0, 41894.58105418968, 41960.370594441105, 42748.572514274456, 42922.0, 43291.35062974058, 7224.74713385029, 7370.226126256666, 8064.717734879251, 8251.463654862415, 8461.223552435744, 30546.389072218877, 31506.842465787526, 31517.0, 31780.36439271248, 33429.662813487186, 40723.59276407198, 40755.16601752869, 40953.18093638051, 40955.1808963825, 41622.0, 9454.527273636428, 9761.853572196565, 9905.752356191153, 10037.69886903394, 10110.69667909964, 11423.714407139889, 11425.143114266297, 11540.596079137189, 11585.362805045803, 11630.825537617111, 10043.246756493147, 10133.44266065344, 10212.642557510748, 10280.588776448858, 11013.229073965065, 10687.465626718478, 11005.119590432907, 11120.555177793121, 11263.436828158396, 11274.267172633752, 10406.479676016017, 10891.400972946563, 10920.945395272973, 11001.78980312181, 11250.324980501196, 9071.138241867013, 9217.861732074158, 9337.388186113598, 9417.858732118886, 9811.460369679737, 8850.867236991322, 8870.246029087342, 8952.820943581222, 9063.909360906306, 9175.128362805523], "unit": "ms", "name": "yui.html", "value": 5746.419233049857}], "name": "dromaeo_css", "value": 6291.847140303698}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 111.0, 111.0, 112.0, 100.0, 111.0, 115.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [154.0, 133.0, 151.0, 167.0, 130.0, 153.0, 151.0, 131.0, 164.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 164.0, 163.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 84.0, 88.0, 72.0, 73.0, 73.0, 107.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 123.0, 91.0, 92.0, 92.0, 130.0, 91.0, 91.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 103.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 71.0, 69.0, 71.0, 69.0, 79.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 81.0, 88.0, 82.0, 81.0, 83.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 127.0, 120.0, 138.0, 120.0, 120.0, 120.0, 127.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [140.0, 136.0, 147.0, 152.0, 160.0, 137.0, 146.0, 145.0, 144.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1513.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.3453119895459], "unit": "score", "name": "Richards", "value": 216.118844}, {"lowerIsBetter": false, "replicates": [191.75455417066155], "unit": "score", "name": "DeltaBlue", "value": 344.80537}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [618.0469715698393], "unit": "score", "name": "Splay", "value": 131.852438}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19806.71713198853}]} 16:47:36 INFO - RETURN: dromaeo_css: 6291.85 16:47:36 INFO - RETURN: kraken: 1513.30 16:47:36 INFO - RETURN: v8_7: 19806.72 16:47:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19806.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1513.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6291.85"}}} 16:47:36 INFO - Return code: 0 16:47:36 INFO - # TBPL SUCCESS # 16:47:36 INFO - Running post-action listener: _resource_record_post_action 16:47:36 INFO - Running post-run listener: _resource_record_post_run 16:47:37 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508792832; Read time: 208; Write time: 643432 16:47:37 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 173182976; Read time: 0; Write time: 223344 16:47:37 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280215552; Read time: 208; Write time: 238912 16:47:37 INFO - Running post-run listener: _upload_blobber_files 16:47:37 INFO - Blob upload gear active. 16:47:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:47:37 INFO - Copying logs to upload dir... 16:47:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1260.442171 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-20 16:47:37.761390) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:47:37.765331) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009980 build_url: 'https://queue.taskcluster.net/v1/task/O4M9aJFGQ4SDSRJHxIoB4w/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-11-20 16:47:37.817234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:47:37.817628) ========= 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=b00de3c228505fac2445e70d000001bb-1448065593.581973-2036925928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:47:37.871215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:47:37.872031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:47:37.872701) ========= ========= Total master_lag: 1.51 =========