builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1447999355.18 results: success (0) buildid: 20151119205634 builduid: 704f9cb67ce845c4a415f3bc386b24e4 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.182170) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.182672) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.182958) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006587 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.209589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.209882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.251724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.251966) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.302439) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.302701) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.303049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.303331) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 22:02:36-- 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% 47.0M=0s 2015-11-19 22:02:36 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.440448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.440748) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.490599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:35.490915) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 22:02:36,579 truncating revision to first 12 chars 2015-11-19 22:02:36,579 Setting DEBUG logging. 2015-11-19 22:02:36,579 attempt 1/10 2015-11-19 22:02:36,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 22:02:36,932 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652344 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:36.155670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:36.156063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:36.166428) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:36.166802) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:02:36.167263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-19 22:02:36.167558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:02:37 INFO - MultiFileLogger online at 20151119 22:02:37 in /builds/slave/test 22:02:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:02:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:02:37 INFO - {'append_to_log': False, 22:02:37 INFO - 'base_work_dir': '/builds/slave/test', 22:02:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:02:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:02:37 INFO - 'branch': 'Firefox-Non-PGO', 22:02:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:02:37 INFO - 'config_files': ('talos/linux_config.py',), 22:02:37 INFO - 'default_actions': ('clobber', 22:02:37 INFO - 'read-buildbot-config', 22:02:37 INFO - 'download-and-extract', 22:02:37 INFO - 'populate-webroot', 22:02:37 INFO - 'create-virtualenv', 22:02:37 INFO - 'install', 22:02:37 INFO - 'run-tests'), 22:02:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:02:37 INFO - 'download_minidump_stackwalk': True, 22:02:37 INFO - 'download_symbols': 'ondemand', 22:02:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:02:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:02:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:02:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:02:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:02:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:02:37 INFO - 'installer_path': 'installer.exe', 22:02:37 INFO - 'log_level': 'info', 22:02:37 INFO - 'log_name': 'talos', 22:02:37 INFO - 'log_to_console': True, 22:02:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:02:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:02:37 INFO - 'opt_config_files': (), 22:02:37 INFO - 'pip_index': False, 22:02:37 INFO - 'sps_profile': False, 22:02:37 INFO - 'sps_profile_interval': 0, 22:02:37 INFO - 'suite': 'dromaeojs', 22:02:37 INFO - 'system_bits': '64', 22:02:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:02:37 INFO - 'title': 'talos-linux64-ix-064', 22:02:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:02:37 INFO - 'use_talos_json': True, 22:02:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:02:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:02:37 INFO - 'work_dir': 'build'} 22:02:37 INFO - ##### 22:02:37 INFO - ##### Running clobber step. 22:02:37 INFO - ##### 22:02:37 INFO - Running pre-action listener: _resource_record_pre_action 22:02:37 INFO - Running main action method: clobber 22:02:37 INFO - rmtree: /builds/slave/test/build 22:02:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:02:37 INFO - Running post-action listener: _resource_record_post_action 22:02:37 INFO - ##### 22:02:37 INFO - ##### Running read-buildbot-config step. 22:02:37 INFO - ##### 22:02:37 INFO - Running pre-action listener: _resource_record_pre_action 22:02:37 INFO - Running main action method: read_buildbot_config 22:02:37 INFO - Using buildbot properties: 22:02:37 INFO - { 22:02:37 INFO - "properties": { 22:02:37 INFO - "buildnumber": 363, 22:02:37 INFO - "product": "firefox", 22:02:37 INFO - "script_repo_revision": "production", 22:02:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:02:37 INFO - "repository": "", 22:02:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:02:37 INFO - "buildid": "20151119205634", 22:02:37 INFO - "slavename": "talos-linux64-ix-064", 22:02:37 INFO - "pgo_build": "False", 22:02:37 INFO - "basedir": "/builds/slave/test", 22:02:37 INFO - "project": "", 22:02:37 INFO - "platform": "ubuntu64_hw", 22:02:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:02:37 INFO - "slavebuilddir": "test", 22:02:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:02:37 INFO - "branch": "mozilla-central", 22:02:37 INFO - "repo_path": "mozilla-central", 22:02:37 INFO - "stage_platform": "linux64", 22:02:37 INFO - "builduid": "704f9cb67ce845c4a415f3bc386b24e4", 22:02:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:02:37 INFO - }, 22:02:37 INFO - "sourcestamp": { 22:02:37 INFO - "repository": "", 22:02:37 INFO - "hasPatch": false, 22:02:37 INFO - "project": "", 22:02:37 INFO - "branch": "mozilla-central-linux64-talos", 22:02:37 INFO - "changes": [ 22:02:37 INFO - { 22:02:37 INFO - "category": null, 22:02:37 INFO - "files": [ 22:02:37 INFO - { 22:02:37 INFO - "url": null, 22:02:37 INFO - "name": "https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:02:37 INFO - } 22:02:37 INFO - ], 22:02:37 INFO - "repository": "", 22:02:37 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 22:02:37 INFO - "who": "philringnalda@gmail.com", 22:02:37 INFO - "when": 1447999302, 22:02:37 INFO - "number": 6686959, 22:02:37 INFO - "comments": "Backed out 2 changesets (bug 1225007) for frequent OS X \"Shouldn't return empty rect\" assertion failures, a=backout\n\nBacked out changeset c5b352c74b35 (bug 1225007)\nBacked out changeset 8a513c70ce7c (bug 1225007)", 22:02:37 INFO - "project": "", 22:02:37 INFO - "at": "Thu 19 Nov 2015 22:01:42", 22:02:37 INFO - "branch": "mozilla-central-linux64-talos", 22:02:37 INFO - "revlink": "", 22:02:37 INFO - "properties": [ 22:02:37 INFO - [ 22:02:37 INFO - "buildid", 22:02:37 INFO - "20151119205634", 22:02:37 INFO - "Change" 22:02:37 INFO - ], 22:02:37 INFO - [ 22:02:37 INFO - "builduid", 22:02:37 INFO - "704f9cb67ce845c4a415f3bc386b24e4", 22:02:37 INFO - "Change" 22:02:37 INFO - ], 22:02:37 INFO - [ 22:02:37 INFO - "pgo_build", 22:02:37 INFO - "False", 22:02:37 INFO - "Change" 22:02:37 INFO - ] 22:02:37 INFO - ], 22:02:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:02:37 INFO - } 22:02:37 INFO - ], 22:02:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 22:02:37 INFO - } 22:02:37 INFO - } 22:02:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:02:37 INFO - Running post-action listener: _resource_record_post_action 22:02:37 INFO - ##### 22:02:37 INFO - ##### Running download-and-extract step. 22:02:37 INFO - ##### 22:02:37 INFO - Running pre-action listener: _resource_record_pre_action 22:02:37 INFO - Running main action method: download_and_extract 22:02:37 INFO - mkdir: /builds/slave/test/build/tests 22:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:37 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json 22:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json 22:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:02:38 INFO - Downloaded 1302 bytes. 22:02:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:02:38 INFO - Using the following test package requirements: 22:02:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:02:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'jsshell-linux-x86_64.zip'], 22:02:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:02:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:02:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:02:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:02:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:02:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:02: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')]} 22:02:38 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:02:39 INFO - Downloaded 21336489 bytes. 22:02:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:02:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:02:40 INFO - Return code: 0 22:02:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:40 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:02:43 INFO - Downloaded 21336489 bytes. 22:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:02:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:02:44 INFO - Return code: 0 22:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:44 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:02:46 INFO - Downloaded 11130997 bytes. 22:02:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:02:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:02:47 INFO - Return code: 0 22:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:47 INFO - https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:02:48 INFO - Downloaded 55781650 bytes. 22:02:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:02:48 INFO - mkdir: /builds/slave/test/properties 22:02:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:02:48 INFO - Writing to file /builds/slave/test/properties/build_url 22:02:48 INFO - Contents: 22:02:48 INFO - build_url:https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:02:48 INFO - Running post-action listener: _resource_record_post_action 22:02:48 INFO - Running post-action listener: set_extra_try_arguments 22:02:48 INFO - ##### 22:02:48 INFO - ##### Running populate-webroot step. 22:02:48 INFO - ##### 22:02:48 INFO - Running pre-action listener: _resource_record_pre_action 22:02:48 INFO - Running main action method: populate_webroot 22:02:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:02:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:02:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:02:48 INFO - '../fennec_ids.txt'], 22:02:48 INFO - 'tests': ['tcheck2']}, 22:02:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:02:48 INFO - '--tppagecycles', 22:02:48 INFO - '7'], 22:02:48 INFO - 'tests': ['tsvgm']}}, 22:02:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:02:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:02:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:02:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:02:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'tests': ['damp', 'tps']}, 22:02:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['damp', 'tps']}, 22:02:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:02:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:02:48 INFO - 'other': {'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'other_l64': {'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'other_nol64': {'tests': ['a11yr', 22:02:48 INFO - 'ts_paint', 22:02:48 INFO - 'tpaint', 22:02:48 INFO - 'sessionrestore', 22:02:48 INFO - 'sessionrestore_no_auto_restore']}, 22:02:48 INFO - 'svgr': {'tests': ['tsvgx', 22:02:48 INFO - 'tsvgr_opacity', 22:02:48 INFO - 'tart', 22:02:48 INFO - 'tscrollx', 22:02:48 INFO - 'cart']}, 22:02:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['tsvgx', 22:02:48 INFO - 'tsvgr_opacity', 22:02:48 INFO - 'tart', 22:02:48 INFO - 'tscrollx', 22:02:48 INFO - 'cart']}, 22:02:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'tests': ['tp5o']}, 22:02:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'talos_options': ['--e10s'], 22:02:48 INFO - 'tests': ['tp5o']}, 22:02:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'talos_options': ['--xperf_path', 22:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:48 INFO - 'tests': ['tp5n']}, 22:02:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:48 INFO - 'talos_options': ['--e10s', 22:02:48 INFO - '--xperf_path', 22:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:48 INFO - 'tests': ['tp5n']}}, 22:02:48 INFO - 'talos.zip': {'path': '', 22:02:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:02:48 INFO - Running post-action listener: _resource_record_post_action 22:02:48 INFO - ##### 22:02:48 INFO - ##### Running create-virtualenv step. 22:02:48 INFO - ##### 22:02:48 INFO - Running pre-action listener: _resource_record_pre_action 22:02:48 INFO - Running main action method: create_virtualenv 22:02:48 INFO - Creating virtualenv /builds/slave/test/build/venv 22:02:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:02:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:02:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:02:48 INFO - Using real prefix '/usr' 22:02:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:02:49 INFO - Installing distribute.............................................................................................................................................................................................done. 22:02:51 INFO - Installing pip.................done. 22:02:51 INFO - Return code: 0 22:02:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02: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', 'pip>=1.5'] in /builds/slave/test/build 22:02: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 pip>=1.5 22:02:51 INFO - Using env: {'DISPLAY': ':0', 22:02:51 INFO - 'HOME': '/home/cltbld', 22:02:51 INFO - 'LANG': 'en_US.UTF-8', 22:02:51 INFO - 'LANGUAGE': 'en_US:en', 22:02:51 INFO - 'LOGNAME': 'cltbld', 22:02:51 INFO - 'MAIL': '/var/mail/cltbld', 22:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:51 INFO - 'MOZ_NO_REMOTE': '1', 22:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:51 INFO - 'NO_EM_RESTART': '1', 22:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:51 INFO - 'PWD': '/builds/slave/test', 22:02:51 INFO - 'SHELL': '/bin/bash', 22:02:51 INFO - 'SHLVL': '1', 22:02:51 INFO - 'TERM': 'linux', 22:02:51 INFO - 'TMOUT': '86400', 22:02:51 INFO - 'USER': 'cltbld', 22:02:51 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:51 INFO - '_': '/tools/buildbot/bin/python'} 22:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:02:51 INFO - Cleaning up... 22:02:51 INFO - Return code: 0 22:02:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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', '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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:02: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 psutil>=0.7.1 22:02:51 INFO - Using env: {'DISPLAY': ':0', 22:02:51 INFO - 'HOME': '/home/cltbld', 22:02:51 INFO - 'LANG': 'en_US.UTF-8', 22:02:51 INFO - 'LANGUAGE': 'en_US:en', 22:02:51 INFO - 'LOGNAME': 'cltbld', 22:02:51 INFO - 'MAIL': '/var/mail/cltbld', 22:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:51 INFO - 'MOZ_NO_REMOTE': '1', 22:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:51 INFO - 'NO_EM_RESTART': '1', 22:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:51 INFO - 'PWD': '/builds/slave/test', 22:02:51 INFO - 'SHELL': '/bin/bash', 22:02:51 INFO - 'SHLVL': '1', 22:02:51 INFO - 'TERM': 'linux', 22:02:51 INFO - 'TMOUT': '86400', 22:02:51 INFO - 'USER': 'cltbld', 22:02:51 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:51 INFO - '_': '/tools/buildbot/bin/python'} 22:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:51 INFO - Downloading/unpacking psutil>=0.7.1 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:02:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:53 INFO - Installing collected packages: psutil 22:02:53 INFO - Running setup.py install for psutil 22:02:53 INFO - building 'psutil._psutil_linux' extension 22:02:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:02:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:02:53 INFO - building 'psutil._psutil_posix' extension 22:02:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:02:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:53 INFO - Successfully installed psutil 22:02:53 INFO - Cleaning up... 22:02:53 INFO - Return code: 0 22:02:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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', '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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:02: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 mozsystemmonitor==0.0.0 22:02:53 INFO - Using env: {'DISPLAY': ':0', 22:02:53 INFO - 'HOME': '/home/cltbld', 22:02:53 INFO - 'LANG': 'en_US.UTF-8', 22:02:53 INFO - 'LANGUAGE': 'en_US:en', 22:02:53 INFO - 'LOGNAME': 'cltbld', 22:02:53 INFO - 'MAIL': '/var/mail/cltbld', 22:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:53 INFO - 'MOZ_NO_REMOTE': '1', 22:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:53 INFO - 'NO_EM_RESTART': '1', 22:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:53 INFO - 'PWD': '/builds/slave/test', 22:02:53 INFO - 'SHELL': '/bin/bash', 22:02:53 INFO - 'SHLVL': '1', 22:02:53 INFO - 'TERM': 'linux', 22:02:53 INFO - 'TMOUT': '86400', 22:02:53 INFO - 'USER': 'cltbld', 22:02:53 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:53 INFO - '_': '/tools/buildbot/bin/python'} 22:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:02:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:02:55 INFO - Installing collected packages: mozsystemmonitor 22:02:55 INFO - Running setup.py install for mozsystemmonitor 22:02:55 INFO - Successfully installed mozsystemmonitor 22:02:55 INFO - Cleaning up... 22:02:55 INFO - Return code: 0 22:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:55 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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:02:55 INFO - Using env: {'DISPLAY': ':0', 22:02:55 INFO - 'HOME': '/home/cltbld', 22:02:55 INFO - 'LANG': 'en_US.UTF-8', 22:02:55 INFO - 'LANGUAGE': 'en_US:en', 22:02:55 INFO - 'LOGNAME': 'cltbld', 22:02:55 INFO - 'MAIL': '/var/mail/cltbld', 22:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:55 INFO - 'MOZ_NO_REMOTE': '1', 22:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:55 INFO - 'NO_EM_RESTART': '1', 22:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:55 INFO - 'PWD': '/builds/slave/test', 22:02:55 INFO - 'SHELL': '/bin/bash', 22:02:55 INFO - 'SHLVL': '1', 22:02:55 INFO - 'TERM': 'linux', 22:02:55 INFO - 'TMOUT': '86400', 22:02:55 INFO - 'USER': 'cltbld', 22:02:55 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:55 INFO - '_': '/tools/buildbot/bin/python'} 22:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:02:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:58 INFO - Downloading docopt-0.6.1.tar.gz 22:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:02:58 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:58 INFO - Running setup.py install for blobuploader 22:02:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:02:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:02:58 INFO - Running setup.py install for requests 22:02:58 INFO - Running setup.py install for docopt 22:02:59 INFO - Successfully installed blobuploader requests docopt 22:02:59 INFO - Cleaning up... 22:02:59 INFO - Return code: 0 22:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:59 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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:59 INFO - Using env: {'DISPLAY': ':0', 22:02:59 INFO - 'HOME': '/home/cltbld', 22:02:59 INFO - 'LANG': 'en_US.UTF-8', 22:02:59 INFO - 'LANGUAGE': 'en_US:en', 22:02:59 INFO - 'LOGNAME': 'cltbld', 22:02:59 INFO - 'MAIL': '/var/mail/cltbld', 22:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:59 INFO - 'MOZ_NO_REMOTE': '1', 22:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:59 INFO - 'NO_EM_RESTART': '1', 22:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:59 INFO - 'PWD': '/builds/slave/test', 22:02:59 INFO - 'SHELL': '/bin/bash', 22:02:59 INFO - 'SHLVL': '1', 22:02:59 INFO - 'TERM': 'linux', 22:02:59 INFO - 'TMOUT': '86400', 22:02:59 INFO - 'USER': 'cltbld', 22:02:59 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:59 INFO - '_': '/tools/buildbot/bin/python'} 22:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:59 INFO - Running setup.py (path:/tmp/pip-HQOpSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:59 INFO - Running setup.py (path:/tmp/pip-K96DEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:59 INFO - Running setup.py (path:/tmp/pip-76eEub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:59 INFO - Running setup.py (path:/tmp/pip-8PGmg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:59 INFO - Running setup.py (path:/tmp/pip-A0R9bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:59 INFO - Running setup.py (path:/tmp/pip-0PTWjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:59 INFO - Running setup.py (path:/tmp/pip-34svB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:59 INFO - Running setup.py (path:/tmp/pip-Y4xcjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:59 INFO - Running setup.py (path:/tmp/pip-ziOpmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:59 INFO - Running setup.py (path:/tmp/pip-tA__2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:03:00 INFO - Running setup.py (path:/tmp/pip-i8D_qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:03:00 INFO - Running setup.py (path:/tmp/pip-mEcT0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:03:00 INFO - Running setup.py (path:/tmp/pip-6nzyFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:03:00 INFO - Running setup.py (path:/tmp/pip-bLRoo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:03:00 INFO - Running setup.py (path:/tmp/pip-MaMfaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:03:00 INFO - Running setup.py (path:/tmp/pip-Nh4PU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:03:00 INFO - Running setup.py (path:/tmp/pip-yPgQ6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:03:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:03:00 INFO - Running setup.py install for manifestparser 22:03:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:03:00 INFO - Running setup.py install for mozcrash 22:03:00 INFO - Running setup.py install for mozdebug 22:03:00 INFO - Running setup.py install for mozdevice 22:03:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:03:00 INFO - Running setup.py install for mozfile 22:03:01 INFO - Running setup.py install for mozhttpd 22:03:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for mozinfo 22:03:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for mozInstall 22:03:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for mozleak 22:03:01 INFO - Running setup.py install for mozlog 22:03:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for moznetwork 22:03:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for mozprocess 22:03:01 INFO - Running setup.py install for mozprofile 22:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:03:01 INFO - Running setup.py install for mozrunner 22:03:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:03:02 INFO - Running setup.py install for mozscreenshot 22:03:02 INFO - Running setup.py install for moztest 22:03:02 INFO - Running setup.py install for mozversion 22:03:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:03:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:03:02 INFO - Cleaning up... 22:03:02 INFO - Return code: 0 22:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:02 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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:03:02 INFO - Using env: {'DISPLAY': ':0', 22:03:02 INFO - 'HOME': '/home/cltbld', 22:03:02 INFO - 'LANG': 'en_US.UTF-8', 22:03:02 INFO - 'LANGUAGE': 'en_US:en', 22:03:02 INFO - 'LOGNAME': 'cltbld', 22:03:02 INFO - 'MAIL': '/var/mail/cltbld', 22:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:02 INFO - 'MOZ_NO_REMOTE': '1', 22:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:02 INFO - 'NO_EM_RESTART': '1', 22:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:03:02 INFO - 'PWD': '/builds/slave/test', 22:03:02 INFO - 'SHELL': '/bin/bash', 22:03:02 INFO - 'SHLVL': '1', 22:03:02 INFO - 'TERM': 'linux', 22:03:02 INFO - 'TMOUT': '86400', 22:03:02 INFO - 'USER': 'cltbld', 22:03:02 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:02 INFO - '_': '/tools/buildbot/bin/python'} 22:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:03:02 INFO - Running setup.py (path:/tmp/pip-ojeGRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:03:02 INFO - Running setup.py (path:/tmp/pip-MrPtic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:03:02 INFO - Running setup.py (path:/tmp/pip-8EZgJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:03:02 INFO - Running setup.py (path:/tmp/pip-p8SbGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:03:02 INFO - Running setup.py (path:/tmp/pip-R9MMef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:03:02 INFO - Running setup.py (path:/tmp/pip-ApQJ5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:03:03 INFO - Running setup.py (path:/tmp/pip-M2auqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:03:03 INFO - Running setup.py (path:/tmp/pip-l7oYt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:03:03 INFO - Running setup.py (path:/tmp/pip-T0KGLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:03:03 INFO - Running setup.py (path:/tmp/pip-79BaEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:03:03 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)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:03:03 INFO - Running setup.py (path:/tmp/pip-RBId0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:03:03 INFO - Running setup.py (path:/tmp/pip-6gehMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:03:03 INFO - Running setup.py (path:/tmp/pip-HFTV1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:03:03 INFO - Running setup.py (path:/tmp/pip-W8DPug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:03:03 INFO - Running setup.py (path:/tmp/pip-HGSaTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:03:03 INFO - Running setup.py (path:/tmp/pip-hNc3kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:03:03 INFO - Running setup.py (path:/tmp/pip-F9GQuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:03: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:03:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:05 INFO - Downloading blessings-1.5.1.tar.gz 22:03:05 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:03:05 INFO - Installing collected packages: blessings 22:03:05 INFO - Running setup.py install for blessings 22:03:05 INFO - Successfully installed blessings 22:03:05 INFO - Cleaning up... 22:03:05 INFO - Return code: 0 22:03:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:03:05 INFO - Reading from file tmpfile_stdout 22:03:05 INFO - Current package versions: 22:03:05 INFO - argparse == 1.2.1 22:03:05 INFO - blessings == 1.5.1 22:03:05 INFO - blobuploader == 1.2.4 22:03:05 INFO - docopt == 0.6.1 22:03:05 INFO - manifestparser == 1.1 22:03:05 INFO - mozInstall == 1.12 22:03:05 INFO - mozcrash == 0.16 22:03:05 INFO - mozdebug == 0.1 22:03:05 INFO - mozdevice == 0.47 22:03:05 INFO - mozfile == 1.2 22:03:05 INFO - mozhttpd == 0.7 22:03:05 INFO - mozinfo == 0.9 22:03:05 INFO - mozleak == 0.1 22:03:05 INFO - mozlog == 3.0 22:03:05 INFO - moznetwork == 0.27 22:03:05 INFO - mozprocess == 0.22 22:03:05 INFO - mozprofile == 0.27 22:03:05 INFO - mozrunner == 6.11 22:03:05 INFO - mozscreenshot == 0.1 22:03:05 INFO - mozsystemmonitor == 0.0 22:03:05 INFO - moztest == 0.7 22:03:05 INFO - mozversion == 1.4 22:03:05 INFO - psutil == 3.1.1 22:03:05 INFO - requests == 1.2.3 22:03:05 INFO - wsgiref == 0.1.2 22:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:05 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 0x7ffe33811c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:03:05 INFO - Using env: {'DISPLAY': ':0', 22:03:05 INFO - 'HOME': '/home/cltbld', 22:03:05 INFO - 'LANG': 'en_US.UTF-8', 22:03:05 INFO - 'LANGUAGE': 'en_US:en', 22:03:05 INFO - 'LOGNAME': 'cltbld', 22:03:05 INFO - 'MAIL': '/var/mail/cltbld', 22:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:05 INFO - 'MOZ_NO_REMOTE': '1', 22:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:05 INFO - 'NO_EM_RESTART': '1', 22:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:03:05 INFO - 'PWD': '/builds/slave/test', 22:03:05 INFO - 'SHELL': '/bin/bash', 22:03:05 INFO - 'SHLVL': '1', 22:03:05 INFO - 'TERM': 'linux', 22:03:05 INFO - 'TMOUT': '86400', 22:03:05 INFO - 'USER': 'cltbld', 22:03:05 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:05 INFO - '_': '/tools/buildbot/bin/python'} 22:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:03:06 INFO - Cleaning up... 22:03:06 INFO - Return code: 0 22:03:06 INFO - Running post-action listener: _resource_record_post_action 22:03:06 INFO - Running post-action listener: _start_resource_monitoring 22:03:06 INFO - Starting resource monitoring. 22:03:06 INFO - ##### 22:03:06 INFO - ##### Running install step. 22:03:06 INFO - ##### 22:03:06 INFO - Running pre-action listener: _resource_record_pre_action 22:03:06 INFO - Running main action method: install 22:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:03:06 INFO - Reading from file tmpfile_stdout 22:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:03:06 INFO - Reading from file tmpfile_stdout 22:03:06 INFO - Output received: 22:03:06 INFO - Usage: mozinstall [options] installer 22:03:06 INFO - Options: 22:03:06 INFO - -h, --help show this help message and exit 22:03:06 INFO - -d DEST, --destination=DEST 22:03:06 INFO - Directory to install application into. [default: 22:03:06 INFO - "/builds/slave/test"] 22:03:06 INFO - --app=APP Application being installed. [default: firefox] 22:03:06 INFO - mkdir: /builds/slave/test/build/application 22:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:03:20 INFO - Reading from file tmpfile_stdout 22:03:20 INFO - Output received: 22:03:20 INFO - /builds/slave/test/build/application/firefox/firefox 22:03:20 INFO - Running post-action listener: _resource_record_post_action 22:03:20 INFO - ##### 22:03:20 INFO - ##### Running run-tests step. 22:03:20 INFO - ##### 22:03:20 INFO - Running pre-action listener: _resource_record_pre_action 22:03:20 INFO - Running main action method: run_tests 22:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:03:20 INFO - Python 2.7.3 22:03:20 INFO - Return code: 0 22:03:20 INFO - grabbing minidump binary from tooltool 22:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:20 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 0x1c89b70>, '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 0x1cdadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:03:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:03:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:03:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:03:20 INFO - Return code: 0 22:03:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:03:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:03:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:03:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:03:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] in /builds/slave/test/build 22:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost 22:03:20 INFO - Using env: {'DISPLAY': ':0', 22:03:20 INFO - 'HOME': '/home/cltbld', 22:03:20 INFO - 'LANG': 'en_US.UTF-8', 22:03:20 INFO - 'LANGUAGE': 'en_US:en', 22:03:20 INFO - 'LOGNAME': 'cltbld', 22:03:20 INFO - 'MAIL': '/var/mail/cltbld', 22:03:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:03:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:20 INFO - 'MOZ_NO_REMOTE': '1', 22:03:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:20 INFO - 'NO_EM_RESTART': '1', 22:03:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:03:20 INFO - 'PWD': '/builds/slave/test', 22:03:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:03:20 INFO - 'SHELL': '/bin/bash', 22:03:20 INFO - 'SHLVL': '1', 22:03:20 INFO - 'TERM': 'linux', 22:03:20 INFO - 'TMOUT': '86400', 22:03:20 INFO - 'USER': 'cltbld', 22:03:20 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105', 22:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:20 INFO - '_': '/tools/buildbot/bin/python'} 22:03:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] with output_timeout 3600 22:03:20 INFO - mozversion INFO | application_buildid: 20151119205634 22:03:20 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 22:03:20 INFO - mozversion INFO | application_display_name: Nightly 22:03:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:03:20 INFO - mozversion INFO | application_name: Firefox 22:03:20 INFO - mozversion INFO | application_remotingname: firefox 22:03:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 22:03:20 INFO - mozversion INFO | application_vendor: Mozilla 22:03:20 INFO - mozversion INFO | application_version: 45.0a1 22:03:20 INFO - mozversion INFO | platform_buildid: 20151119205634 22:03:20 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 22:03:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 22:03:20 INFO - mozversion INFO | platform_version: 45.0a1 22:03:20 INFO - 2015-11-19 22:03:20,823 DEBUG : using testdate: 1447999400 22:03:20 INFO - 2015-11-19 22:03:20,823 DEBUG : actual date: 1447999400 22:03:20 INFO - 2015-11-19 22:03:20,832 INFO : starting webserver on 'localhost:38804' 22:03:20 INFO - 2015-11-19 22:03:20,833 INFO : Starting test suite talos-linux64-ix-064 22:03:20 INFO - 2015-11-19 22:03:20,833 INFO : Starting test dromaeo_css 22:03:20 INFO - 2015-11-19 22:03:20,833 DEBUG : operating with platform_type : linux_ 22:03:20 INFO - 2015-11-19 22:03:20,834 INFO : Initialising browser for dromaeo_css test... 22:03:20 INFO - 2015-11-19 22:03:20,849 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4WlNK/profile http://localhost:38804/getInfo.html 22:03:25 INFO - 2015-11-19 22:03:25,168 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:03:25 INFO - 2015-11-19 22:03:25,168 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:03:25 INFO - 2015-11-19 22:03:25,168 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:03:25 INFO - 2015-11-19 22:03:25,168 DEBUG : BROWSER_OUTPUT: __metrics 22:03:25 INFO - 2015-11-19 22:03:25,269 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:03:26 INFO - 2015-11-19 22:03:26,519 INFO : Browser initialized. 22:03:26 INFO - 2015-11-19 22:03:26,520 INFO : Running cycle 1/1 for dromaeo_css test... 22:03:26 INFO - 2015-11-19 22:03:26,520 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4WlNK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:03:38 INFO - 2015-11-19 22:03:38,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 22:03:38 INFO - 2015-11-19 22:03:38,461 DEBUG : BROWSER_OUTPUT: 22:04:29 INFO - 2015-11-19 22:04:29,950 DEBUG : BROWSER_OUTPUT: 1447999469947 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:06:42 INFO - 2015-11-19 22:06:42,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38804/tests/dromaeo/cssquery-ext.html) 22:06:43 INFO - 2015-11-19 22:06:43,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 244899840 22:06:43 INFO - 2015-11-19 22:06:43,256 DEBUG : BROWSER_OUTPUT: 22:09:45 INFO - 2015-11-19 22:09:45,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-ext.html (next: http://localhost:38804/tests/dromaeo/cssquery-jquery.html) 22:09:46 INFO - 2015-11-19 22:09:46,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 213815296 22:09:46 INFO - 2015-11-19 22:09:46,444 DEBUG : BROWSER_OUTPUT: 22:12:48 INFO - 2015-11-19 22:12:48,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38804/tests/dromaeo/cssquery-mootools.html) 22:12:48 INFO - 2015-11-19 22:12:48,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 209276928 22:12:48 INFO - 2015-11-19 22:12:48,976 DEBUG : BROWSER_OUTPUT: 22:15:50 INFO - 2015-11-19 22:15:50,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38804/tests/dromaeo/cssquery-prototype.html) 22:15:51 INFO - 2015-11-19 22:15:51,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 200896512 22:15:51 INFO - 2015-11-19 22:15:51,563 DEBUG : BROWSER_OUTPUT: 22:18:54 INFO - 2015-11-19 22:18:54,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38804/tests/dromaeo/cssquery-yui.html) 22:18:54 INFO - 2015-11-19 22:18:54,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 207831040 22:18:54 INFO - 2015-11-19 22:18:54,876 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-yui.html (next: http://localhost:38804/tests/dromaeo/cssquery-dojo.html) 22:21:57 INFO - 2015-11-19 22:21:57,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 263532544 22:21:57 INFO - 2015-11-19 22:21:57,631 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:57 INFO - 2015-11-19 22:21:57,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:57 INFO - 2015-11-19 22:21:57,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:57 INFO - 2015-11-19 22:21:57,633 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:57 INFO - 2015-11-19 22:21:57,636 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.4373181631854;2743.8353698778074;2747.120921305183;2757.255541003929;2771.972280277197;4570.1316749817515;4714.434267887849;4720.268358404449;4757.857264282068;4768.90462190756;4731.290306454025;4742.33607294979;4774.188387974044;4814.205656066745;4818.397700287464;4225.231238676453;4370.060437006043;4481.2381895077915;4501.347304640825;4512.796924138422;4314.784260786948;4486.484054333744;4509.661775366844;4544.522825103366;4552.8634140975655;4251.6173544380845;4332.675049371278;4354.042110735633;4367.039251364695;4375.606195442426;4423.203823311803;4426.203283408985;4432.157890000922;4433.224185767478;4468.597826195625;4393.714408563465;4410.4927933287445;4415.580519850609;4456.821727130911;4470.977645111786;4569.794359253841;4597.586217240431;4720.716756994591;4721.079389519045;4739.64452666048;5121.795128194868;5154.561862241714;5162.948370516285;5164;5176.145935920568;5185.533302002837;5186.896262074775;5192.1692529195525;5232.947670523284;5236.21456781482;4693.13177062248;4703.294505824086;4808.9519104808505;4810.759462026885;4815.542523460265;5300.9734951325;5342.2253773202665;5345.224942383333;5350.5184533392185;5398.379186393537;5100.923486147711;5130.179171332569;5133.358330208724;5133.563647090039;5185.248139019821;4938.987507560942;4998.625103117281;5073.720945348041;5107;5108.106081435734;5016.749162541858;5028.396592408934;5033.496650334937;5037.0681423936685;5083.87290317745;4998.850034498971;5003.449620541737;5008.248762685554;5009.5491405773655;5015.272785446163;4065.5121385433936;4093.058596522757;4150.107726838744;4195.160967806451;4195.7692326922315;3749.1189570450924;3761.605031471711;3771.9811400943368;3782.5650050244576;3816.0269131371324;4459.576340247671;4465.397171381886;4467.106578684211;4492.303692927601;4510.909781804411;4979.327790748275;5088.949110508847;5100.132977393852;5248.160294352885;5250.579953603703;4331.047169622678;4333.025069359369;4380.671449641226;4400.361947517656;4406.052698669801;4564.383808185852;4567.018091110427;4583.449986001701;4599.172149013143;4608.723476591415;4695.272232803921;4932.8766780830765;4934.7285899275885;4941.827036053721;4944.579710724557;5058.64589478733;5088.465711100281;5113.3097031900215;5147.485251474823;5199.038177936943;4874.195757699939;4898.020395920759;4907.2393778964315;4911.926321105258;4915.778789954532;4867.732274724783;5080.872978175576;5082.415522214993;5085.237214417867;5100.923486147636;4985.052839960396;5059.696418214919;5081.33942587476;5202.843914682566;5210.47895210476;4999.425066117297;5002.674826136289;5009.799608015638;5020.221865610836;5051.06555287273;4787.210110331756;5001.749912504433;5023.974880125722;5027.622928280321;5040.8991820162655;4808.08646357191;4857;4860.441049279378;4874.975625121851;4893.21708526634;5039.722815245197;5075.162598171408;5075.441701412916;5085.3134826797905;5086.720230387365;4938;4941.752912354296;4945.1346014448045;4946.62900282473;4983.825566105169 22:21:57 INFO - 2015-11-19 22:21:57,636 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.5595279729014;572.1932075773159;574.4112284907969;576.8327185116314;579.3829571506348;28329.716702832964;28701.856490717542;34210.48684269735;34254.65745342546;34443.48334774974;37450.43824342637;37887;37974.62025379745;37996;38056;7850.293473587376;8004.799880002988;8028.598570071502;8035.397345199104;8041.959790201041;7229.277072292755;7427.14587822402;9938.602455901755;10135.797284054315;10161.644342448017;10042.849357259647;10117.291789574732;10156.94921525395;10161.54273057714;10166.491675416237;7090.858182836366;7236.276372362721;10006.59973601055;10133.189344852393;10137.138343240797;9986.450745209011;10254;10260.435676037814;10262.640807571774;10263.230257730625;37636;38136.42795358072;38165.61834381648;38175.23649527022;38180.80909595462;2932.780041496896;2968.7921845470823;2973.36072744361;2979.463696534623;3471.2710330830555;27869.72130278712;28179.51157627638;28222;28428.147155585364;28661.713382866114;3328.107325011415;3363.209645733251;3379.3410284994434;3471.5139880416764;3512.824358782076;222615;224462;224603;224757;225211;46957.530424696;47796.761016194694;55776;61308.69345653243;63017;56352.71823640855;56468;56641.716791415776;56657.71671141618;56684.716576417675;13831.79252311216;13912.860871391358;13922.582322530341;13951.930240348733;13975.09161904473;10685.732856678645;10694.35833849956;10709.518071686793;10719.83920241197;10894.67315980522;18785.15466803997;18837.90581047086;18839.340623078126;18936.81063189378;18963.715544266848;6976.651167441709;7265.455090868206;7267.563946163247;7308.269173082649;7402.370798482081;826.4256341842362;868.1318681318681;869.686912711436;887.5562218890555;924.3483344242293;26423.73576264251;26657.73342266591;27157.321066973087;27204.319892002462;27266.863665681543;926.8470702334174;986.9358491698017;999.4752754803786;1098.357460885375;1115.1413411672966;13881.4447422104;13922.651933701536;14040.578782636538;14047.719045619031;14123.78814317786;251996;253611;254387;256316;258021;46719;47015.529844701116;47056.5294347059;47188.7640561795;47247.527524725;1051.984220236697;1064.0742553978089;1102.2064113838023;1194.611751180887;1201.3272567362305;23742.852295747638;26042.34894127662;27260.591091133254;27294.590581140903;27360.726392735818;36516.26967460689;37245.627543724215;41869.58130418657;42693.35959960665;42722.78638606787;317268;320763;322897;323073;323389;28379.290517737223;28767.42465150727;28802;28804.567931481462;28821;39083.21833563256;40070.79964600275;40113;40170.39744403895;40972.38541421822;33782;34031;34727.13182170466;34997.65002349944;35367;31068;32781.344373111926;33105.33789324248;33772.831135844164;33791.662083378855;30651;33591.83204083964;34062.48906266457;34066.65933340635;34198.14504637404;26200.8689956549;29723.55414668825;29747.702522974494;30503.847480762455;30763.846180768953;23137.190198342978;23282.41793955097;23736.762632373455;23765.762342376354;23982.640260395758 22:21:57 INFO - 2015-11-19 22:21:57,640 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.2271205719046;341.7641827139274;343.0565943654949;344.1997356146957;351.9841607127679;12504.374781260924;12917.031222658292;14734.926325368371;15013.249337533121;16661.83338166618;15994.76007859883;16054.277557509911;16364.427245046425;16380.918095409506;16397.18014099296;4788.736619485936;5125.513076257768;5131.846044618667;5132.871678208056;5133.640645154841;3554.4668299754985;3627.147620309225;3627.9455808162897;5039.370078740158;5596.692181929992;5757.856053598652;5767.509761670242;5789.594728369016;5796.478316951474;5797.072468405056;5577.553795696354;5794.217780599628;5798.043322851746;5798.333191682926;5803.767849286023;5166.380034395859;5176.171812509981;5183.341330774154;5184.9740751296;5194.142966410538;19994;20638.793612063986;20862.374128776162;21532.677009844865;22127.114915403527;1953.8339241164517;1985.1860737097866;2008.1666108564928;2012.0342235726932;2017.6569983102909;13545.45818167272;13771.380287887068;13889.166650001032;14089.154650720888;14480;1881.9717704234447;1888.8205620466172;1918.7313776071362;1959.480737604536;1978.3669225847734;50822.7458862707;62773.686131569506;66209.66895165494;66392.3360766391;66726.3327366725;15658;15659.217039147998;15725.764113538306;15791.684166316609;15810.446634367972;23285.7671423287;23298.65052024221;23572.64641030386;23598.882005590207;23631.645525317133;8700.956495217484;8867.600957956907;8902.510361930026;8946.418482798597;8979.551022448852;7478.588677622674;7559.811004724926;7584.5070070446345;7634.198409166957;7646.732364367221;7593.962030189924;7657.157712651604;7665;7707.383409327241;7733.7679869604;1766.5053784940237;1769.301126055201;1803.6753384390936;1833.2208811255164;2166.9891650541645;826.2068414322318;876.2639382918252;928.8746019287445;961.8028304197622;965.6909788867495;15858.365665373487;16275.593110172103;16291.511254662379;16385;16584.917075414545;817.4196320612432;832.7168762620738;854.747849384433;894.494610545053;930.5207817973749;7549.73575924851;8473.95763021181;9168.633254669872;9403.29475289356;9424.528773561295;439730;452085;453205;455545;461221;70837;71421.42892855336;72938.63530682419;73123.26876731271;74119.62940185264;1043.9060484556273;1053.1311667874033;1053.2364036073784;1058.0001898206121;1059.3220338983058;14715.337809798371;14838.40646374133;14960.925195373953;15083.698326033198;15117.470888518848;31713.365732684757;32342.83828580842;32741;32908.67091329056;32912;40665.186696265315;42211.1557768849;42230.577694222666;42671.786641066596;42714;8709.477431354138;9177.311701622271;9302.116298951589;9432.103950124727;9435.24518038569;10437.530311136168;13575.728485430434;16706.164691765607;17093.316267349663;17210.225539850486;13816.58550243454;13820.930895345458;14038.087524310888;14191.148531088167;14731;12945.09384343087;13095.148815327355;13126.081174317706;13408.731825363244;13409.865901340861;13077;13356.198628082346;14113.858861411254;14727.779083313973;14858.108513489226;8158.265756081981;8213.301869341172;8258.917410826056;8303.501789892625;8359.164083591835;10270.794584108426;11699.766004680028;13530.79703804424;13647.317634118453;13957.441702331793 22:21:57 INFO - 2015-11-19 22:21:57,641 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1272.9236245825246;1657.7844880165578;1702.157432071125;1718.957026074348;1737.83490568396;6320.683965801709;6913.101296831411;7171.497995140342;7176.461765367592;7193.676284567187;6973.616451095188;7080.822979425517;7087.468439867018;7136.536125151862;7177.28227177282;1811.9637607247846;1861.4415675297357;2053.917843286274;2111.229401268541;2137.1344605434824;2171.8045375916163;2182.4871155278497;2184.3446965910243;2184.945376365588;2185.748638906522;2077.439091445309;2117.5235571996254;2127.8297736181066;2128.5530038691895;2130.360891732482;1780.97328540072;1816.582186097205;2034.745656792901;2100.0339843671777;2100.56938327644;2111.2082968886666;2112.8098471137673;2123.3417640531484;2135.0925856511076;2138.6257404954226;7192.892106618405;7238.963805180941;7247.528910620793;7275.1633562140505;7281.1262648482525;4369.6722745794195;4455.487618923833;4470.776461176928;4479.462464504248;4485.372047913294;2869.727375899286;2883.610712553799;2917.737403633662;2933.457310397583;3022.123584160591;881.9823603527893;897.5108565831638;910.6493999810054;913.0960349254191;918.6345210578158;9979.101880830687;9991.900080999243;10003.049710277512;10021.549030293581;10025.047620476043;4034.3948407738485;4089.734167279117;4140.130572579792;4147.647449966787;4179.665626749914;8473.872891906627;8507.234348908629;8517.148285171557;8533.44532605391;8535.701250456204;4455.6212721918355;4462;4466.084452687256;4466.6873318867365;4470.463544374696;3990.341593637075;4044.737092089005;4047.7571345719352;4051.2707712611423;4054.8378064877074;3524.524189234472;3526.0655926179584;3547.450145227494;3552.4848896909803;3575.7496975212007;1125.926814757038;1128.368113856243;1143.2911594811271;1157.3518829455531;1160.0545555372344;879.9824003519893;976.3751199232497;1153.2676750263643;1170.5142365918048;1182.3260741377333;6092.786752463642;6928.584284942919;7084.787456376317;7095.538789978635;7100.218975912646;929.1730359979623;932.7994481186441;996.3374356053143;1006.4917216805467;1049.8320268757116;5315.6279060465395;5430.619856609999;5490.0941344677685;5494.423085575957;5501.504864562208;8709.433886797338;8798.912010879938;8810.383273170817;8880.8667869982;8915.55422228886;8448.57757112142;8723.171298726611;8774.34192435557;8784.60469278884;8806.823863522823;6882.552634078769;6923;6931.896021559681;6975.441964642816;6978.883378659491;6644.136262286065;6677.699503522256;6689.063531105747;6694.163229596301;6715.697793599397;7748.806279842824;7864.21357864209;7868.095169055403;7871.33093687043;7921.643526041457;8010.3992200584025;8045.477043992122;8126.390520710852;8160.224778646019;8183.754487365389;6374.29882712892;6445.097686324012;6446.484281257582;6450.387213214737;6457.644829534421;6860;6917.654117294216;6929.896051559332;6933.0986971693355;6937.132858392701;6193.349698281616;6284.057391391328;6330.177076979963;6435.806925792233;6460.289368169404;6229.937700622936;6269.12232287471;6311.810645680637;6335.208098987627;6432.6462044588;5780.335261444988;5898.528117750484;5903.675297858659;6476.060971159061;6509.316521765147;5363.19552067193;6101.054336577838;6108.08378743192;6123.663198524124;6126;5913.319968203712;5945.881082378415;5958.672273024852;5960.046392577166;5962.850928726816 22:21:57 INFO - 2015-11-19 22:21:57,641 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.4759261662557;307.31928777757264;311.3384058874891;311.86278037663425;316.77825522134503;5253.8949221015555;5347.0909945309295;5358.973205133979;5419.0245755764;5442.319710036246;5218.660787048839;5341.30563026807;5347.144456886899;5372.489613486712;5378.112611419121;4174.958250417495;4188;4201.39079833424;4250.979764856427;4253.680973926952;4011.237864805692;4085.55058943516;4087.3460246360587;4087.591240875918;4242.300020496615;4043.5956404359476;4062.8984275393204;4090.9590904090874;4178.247915375231;4209.284421648327;4206.116715489751;4216.198922204787;4227.175700738358;4229.238737027334;4234.513031001444;3738.140227747606;3742.2328422673286;3743.5882052974152;3747.269282489888;3751.174741556853;5069.923951140736;5181.455947125535;5185.533302002837;5208.817691380821;5212.817551385721;4858.174110401205;4871.8294859679745;4874.098291816025;4874.7562621868765;4878.048780487807;5659;5669.177969194485;5672.035753921843;5672.801451949162;5679;3816.0650640592953;3914.628110329514;3944.1914407546383;4025.75845449274;4082.5509193988933;5836.38717934615;5903.173555702248;5936.97031514844;5939.316978547436;5939.732712027969;4147.605977432139;4169.395437661522;4193.22425351311;4195.853145139906;4203.327467605169;4249.638780703613;4260.893477663083;4263.126059157865;4264.87205383839;4269.893252668646;4688.46082700487;4799.136155492045;4812.51874812523;4818.71087734737;4822.71063736177;5654.123610840326;5659.660420374791;5661.7735290588735;5665.631733937281;5667.376588575254;1491.0904348347499;1510.2448775612195;1510.4260381055349;1511.6470758670928;1512.3043400036106;1037.040737317993;1037.5019990404496;1056.4612047855649;1064.387976913278;1065.1532032034552;4924.079608952511;4930.506949305112;4935.925961110586;4935.950640493621;4936.703797772145;5835.2122463466885;5842.532597392198;5846.1523079153285;5856.619319744203;5858.619189752738;4926.802927882916;4928.310036594879;4929.556339929423;4931.630127740434;4931.778069986859;3084.922876928095;3111.6110486189227;3125.140586338775;3149.9055028349185;3153.8896138635037;5489.533389661923;5494.2857428534035;5498.092814685612;5502.174673798962;5519.172124181405;5973.342932277446;5977.282726072899;5984.3417224105315;5985.40145985398;5987;5492.231087647732;5493.697846618395;5497.147942068986;5503.834884953378;5504.724763761796;5660.179274005329;5774.538036957118;5807.564432667651;5813.970930145322;5827.329857066492;5516.806911758069;5607.41122182165;5686.175504551899;5715.114157305624;5770.422957704196;5527.806526771544;5552.916706249491;5560.638558493685;5561.416051314553;5561.443855614406;4195.930037840331;4197.202531519001;4198.706090573631;4201.096764195712;4202.138561594805;5721.656700597978;5854.882902342015;5858.150568167677;5861.765529378948;5863.589548731718;5628.958642651122;5639.7180140993605;5641.689707066151;5643;5655.066913959151;5631.267935168402;5632.155176723524;5634.197056941739;5636.859078522905;5637.746301416528;5414.160805075219;5514.724263786715;5518.586106042143;5527.640703354269;5528.308961379827;5662.065759149694;5673.574481913791;5689.914651280317;5691.4877661010705;5695.231143795535;5519.779208831602;5522.779088836563;5528.226048353154;5530.86172845666;5536.307961504812 22:21:57 INFO - 2015-11-19 22:21:57,642 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.5689929143225;713.6253466929858;778.7780482562471;785.9685612575497;790.257158271225;11566.768664626712;11816.350100744456;11950.163488555794;11968.102392320588;11982.161248712593;11377.943110284437;11474.139439542027;11477.426128693574;11490.138239632019;11491.367974761406;620.5625034350783;634.3371177119898;794.2018271637025;805.5126648377735;805.8468890910708;796.7968168117122;796.9043714754208;804.5816175588691;805.5972013993004;806.0730160315654;649.9837504062389;660.5508254387015;824.1881746479713;838.5178522349643;839.0267289943666;817.0195765081926;826.2109685250572;827.755812035448;829.0755807274905;829.1128492513013;613.5980932489226;614.2260751453201;614.3150387318153;614.3764079459353;614.6097228260087;12090.939545302217;12193.817092743617;12241.143119981605;12246.693832654166;12282.14025018249;11294.548218071268;11503.597374091867;11812.586559470463;11975.700607484796;12040.638780836502;9252.907470925273;9277.953610231905;9339.066093390675;9354.345195836295;9395.34232603718;3136.575220362493;3196.856141473639;3207.7914935529116;3230.951535726966;3251.382237374915;41506.584934150575;41806.581934180875;41838.58161418377;41902.161956760996;41946;9418.62325506972;9419.576119074658;9562.904370956341;9641.084097010773;9726.513674316257;16866.578335541464;16877.40929067477;16892.662146756997;16914.577135571708;16916.830831691772;5836.678982655994;6121.081837724377;6125.448709616156;6178.938210617926;6226;3319.817410042471;3412.931741365159;3442.4664177052596;3475.6176820549717;3537.4870643756512;2713.945721085567;2746.8214566053543;2751.3259251483514;3003.6695963444004;3103.1931697758296;538.4050624060435;542.5984771269311;542.7449098923499;550.1307933465115;556.6326224691684;448.06578284277;463.5202565344852;494.94803045679686;510.5787725126711;575.7725698349212;7131.89302160468;7230.349268565854;7307.086614173229;7348.742794002184;7579.204183560757;481.6941242311158;507.02995544883476;565.7878295639135;569.2400645138704;577.656294504769;3363.226457914693;3489.8255087246043;3561.14269851737;3592.7485076044427;3615.6022837487853;54202.728986354814;54381.1842822358;54690.45309546933;54752.45247547473;54812.17781733277;47261.763691181324;47293.29060064102;47574;47855.5214447851;47881.281780773315;42671.57328426738;43835.34246986234;44100.11799764051;44752.3287150693;45056.77471612621;6909.827254318682;7073.434125269863;7207.315305046012;7254.202037775946;7288.760017079937;31887.840560797977;32261.677383225866;32385.35229295448;33194.66805331916;33288.500672490416;37020;37051;38171.61828381681;41846.163076737685;42135;8950.283977281671;10110.646127385506;10149.695509134443;10414.791704166026;10768.40773757451;11091.722706932069;11261.943690281496;11340.376279304717;11395.943020284845;11893.345865977455;10682.252242342962;10983.340999540053;11087.279326843729;11129.220954533428;11470.483828227916;10297.691069267934;10453.425061621683;10499.160067194758;10510.737231569272;10519.421431821323;10324.948375258076;10446.05985461312;10491.527881245514;10797.29817561856;10844.891551084389;9039.864402033843;9190.31072669539;9356.95321523388;9439.858402123837;9464.479453630116;8860.911390886267;9075.273978081606;9080.500572468314;9110.635574576943;9283.907160928304 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000517631__endTimestamp 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:57 INFO - 2015-11-19 22:21:57,643 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:21:57 INFO - 2015-11-19 22:21:57,644 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,644 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4730.98 Median:4874.98 stddev:499.83 (10.3%) stddev-sans-first:474.74 22:21:57 INFO - 2015-11-19 22:21:57,644 DEBUG : BROWSER_OUTPUT: Values: 2679.4 2743.8 2747.1 2757.3 2772.0 4570.1 4714.4 4720.3 4757.9 4768.9 4731.3 4742.3 4774.2 4814.2 4818.4 4225.2 4370.1 4481.2 4501.3 4512.8 4314.8 4486.5 4509.7 4544.5 4552.9 4251.6 4332.7 4354.0 4367.0 4375.6 4423.2 4426.2 4432.2 4433.2 4468.6 4393.7 4410.5 4415.6 4456.8 4471.0 4569.8 4597.6 4720.7 4721.1 4739.6 5121.8 5154.6 5162.9 5164.0 5176.1 5185.5 5186.9 5192.2 5232.9 5236.2 4693.1 4703.3 4809.0 4810.8 4815.5 5301.0 5342.2 5345.2 5350.5 5398.4 5100.9 5130.2 5133.4 5133.6 5185.2 4939.0 4998.6 5073.7 5107.0 5108.1 5016.7 5028.4 5033.5 5037.1 5083.9 4998.9 5003.4 5008.2 5009.5 5015.3 4065.5 4093.1 4150.1 4195.2 4195.8 3749.1 3761.6 3772.0 3782.6 3816.0 4459.6 4465.4 4467.1 4492.3 4510.9 4979.3 5088.9 5100.1 5248.2 5250.6 4331.0 4333.0 4380.7 4400.4 4406.1 4564.4 4567.0 4583.4 4599.2 4608.7 4695.3 4932.9 4934.7 4941.8 4944.6 5058.6 5088.5 5113.3 5147.5 5199.0 4874.2 4898.0 4907.2 4911.9 4915.8 4867.7 5080.9 5082.4 5085.2 5100.9 4985.1 5059.7 5081.3 5202.8 5210.5 4999.4 5002.7 5009.8 5020.2 5051.1 4787.2 5001.7 5024.0 5027.6 5040.9 4808.1 4857.0 4860.4 4875.0 4893.2 5039.7 5075.2 5075.4 5085.3 5086.7 4938.0 4941.8 4945.1 4946.6 4983.8 22:21:57 INFO - 2015-11-19 22:21:57,644 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,644 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42571.58 Median:321830.00 stddev:70562.74 (21.9%) stddev-sans-first:70690.17 22:21:57 INFO - 2015-11-19 22:21:57,645 DEBUG : BROWSER_OUTPUT: Values: 557.6 572.2 574.4 576.8 579.4 28329.7 28701.9 34210.5 34254.7 34443.5 37450.4 37887.0 37974.6 37996.0 38056.0 7850.3 8004.8 8028.6 8035.4 8042.0 7229.3 7427.1 9938.6 10135.8 10161.6 10042.8 10117.3 10156.9 10161.5 10166.5 7090.9 7236.3 10006.6 10133.2 10137.1 9986.5 10254.0 10260.4 10262.6 10263.2 37636.0 38136.4 38165.6 38175.2 38180.8 2932.8 2968.8 2973.4 2979.5 3471.3 27869.7 28179.5 28222.0 28428.1 28661.7 3328.1 3363.2 3379.3 3471.5 3512.8 222615.0 224462.0 224603.0 224757.0 225211.0 46957.5 47796.8 55776.0 61308.7 63017.0 56352.7 56468.0 56641.7 56657.7 56684.7 13831.8 13912.9 13922.6 13951.9 13975.1 10685.7 10694.4 10709.5 10719.8 10894.7 18785.2 18837.9 18839.3 18936.8 18963.7 6976.7 7265.5 7267.6 7308.3 7402.4 826.4 868.1 869.7 887.6 924.3 26423.7 26657.7 27157.3 27204.3 27266.9 926.8 986.9 999.5 1098.4 1115.1 13881.4 13922.7 14040.6 14047.7 14123.8 251996.0 253611.0 254387.0 256316.0 258021.0 46719.0 47015.5 47056.5 47188.8 47247.5 1052.0 1064.1 1102.2 1194.6 1201.3 23742.9 26042.3 27260.6 27294.6 27360.7 36516.3 37245.6 41869.6 42693.4 42722.8 317268.0 320763.0 322897.0 323073.0 323389.0 28379.3 28767.4 28802.0 28804.6 28821.0 39083.2 40070.8 40113.0 40170.4 40972.4 33782.0 34031.0 34727.1 34997.7 35367.0 31068.0 32781.3 33105.3 33772.8 33791.7 30651.0 33591.8 34062.5 34066.7 34198.1 26200.9 29723.6 29747.7 30503.8 30763.8 23137.2 23282.4 23736.8 23765.8 23982.6 22:21:57 INFO - 2015-11-19 22:21:57,645 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,646 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26457.76 Median:341.50 stddev:73889.66 (21637.1%) stddev-sans-first:74070.92 22:21:57 INFO - 2015-11-19 22:21:57,646 DEBUG : BROWSER_OUTPUT: Values: 341.2 341.8 343.1 344.2 352.0 12504.4 12917.0 14734.9 15013.2 16661.8 15994.8 16054.3 16364.4 16380.9 16397.2 4788.7 5125.5 5131.8 5132.9 5133.6 3554.5 3627.1 3627.9 5039.4 5596.7 5757.9 5767.5 5789.6 5796.5 5797.1 5577.6 5794.2 5798.0 5798.3 5803.8 5166.4 5176.2 5183.3 5185.0 5194.1 19994.0 20638.8 20862.4 21532.7 22127.1 1953.8 1985.2 2008.2 2012.0 2017.7 13545.5 13771.4 13889.2 14089.2 14480.0 1882.0 1888.8 1918.7 1959.5 1978.4 50822.7 62773.7 66209.7 66392.3 66726.3 15658.0 15659.2 15725.8 15791.7 15810.4 23285.8 23298.7 23572.6 23598.9 23631.6 8701.0 8867.6 8902.5 8946.4 8979.6 7478.6 7559.8 7584.5 7634.2 7646.7 7594.0 7657.2 7665.0 7707.4 7733.8 1766.5 1769.3 1803.7 1833.2 2167.0 826.2 876.3 928.9 961.8 965.7 15858.4 16275.6 16291.5 16385.0 16584.9 817.4 832.7 854.7 894.5 930.5 7549.7 8474.0 9168.6 9403.3 9424.5 439730.0 452085.0 453205.0 455545.0 461221.0 70837.0 71421.4 72938.6 73123.3 74119.6 1043.9 1053.1 1053.2 1058.0 1059.3 14715.3 14838.4 14960.9 15083.7 15117.5 31713.4 32342.8 32741.0 32908.7 32912.0 40665.2 42211.2 42230.6 42671.8 42714.0 8709.5 9177.3 9302.1 9432.1 9435.2 10437.5 13575.7 16706.2 17093.3 17210.2 13816.6 13820.9 14038.1 14191.1 14731.0 12945.1 13095.1 13126.1 13408.7 13409.9 13077.0 13356.2 14113.9 14727.8 14858.1 8158.3 8213.3 8258.9 8303.5 8359.2 10270.8 11699.8 13530.8 13647.3 13957.4 22:21:57 INFO - 2015-11-19 22:21:57,646 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,646 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5080.88 Median:6124.83 stddev:2620.58 (42.8%) stddev-sans-first:2612.30 22:21:57 INFO - 2015-11-19 22:21:57,648 DEBUG : BROWSER_OUTPUT: Values: 1272.9 1657.8 1702.2 1719.0 1737.8 6320.7 6913.1 7171.5 7176.5 7193.7 6973.6 7080.8 7087.5 7136.5 7177.3 1812.0 1861.4 2053.9 2111.2 2137.1 2171.8 2182.5 2184.3 2184.9 2185.7 2077.4 2117.5 2127.8 2128.6 2130.4 1781.0 1816.6 2034.7 2100.0 2100.6 2111.2 2112.8 2123.3 2135.1 2138.6 7192.9 7239.0 7247.5 7275.2 7281.1 4369.7 4455.5 4470.8 4479.5 4485.4 2869.7 2883.6 2917.7 2933.5 3022.1 882.0 897.5 910.6 913.1 918.6 9979.1 9991.9 10003.0 10021.5 10025.0 4034.4 4089.7 4140.1 4147.6 4179.7 8473.9 8507.2 8517.1 8533.4 8535.7 4455.6 4462.0 4466.1 4466.7 4470.5 3990.3 4044.7 4047.8 4051.3 4054.8 3524.5 3526.1 3547.5 3552.5 3575.7 1125.9 1128.4 1143.3 1157.4 1160.1 880.0 976.4 1153.3 1170.5 1182.3 6092.8 6928.6 7084.8 7095.5 7100.2 929.2 932.8 996.3 1006.5 1049.8 5315.6 5430.6 5490.1 5494.4 5501.5 8709.4 8798.9 8810.4 8880.9 8915.6 8448.6 8723.2 8774.3 8784.6 8806.8 6882.6 6923.0 6931.9 6975.4 6978.9 6644.1 6677.7 6689.1 6694.2 6715.7 7748.8 7864.2 7868.1 7871.3 7921.6 8010.4 8045.5 8126.4 8160.2 8183.8 6374.3 6445.1 6446.5 6450.4 6457.6 6860.0 6917.7 6929.9 6933.1 6937.1 6193.3 6284.1 6330.2 6435.8 6460.3 6229.9 6269.1 6311.8 6335.2 6432.6 5780.3 5898.5 5903.7 6476.1 6509.3 5363.2 6101.1 6108.1 6123.7 6126.0 5913.3 5945.9 5958.7 5960.0 5962.9 22:21:57 INFO - 2015-11-19 22:21:57,648 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,648 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4701.77 Median:5236.28 stddev:1353.20 (25.8%) stddev-sans-first:1316.17 22:21:57 INFO - 2015-11-19 22:21:57,650 DEBUG : BROWSER_OUTPUT: Values: 306.5 307.3 311.3 311.9 316.8 5253.9 5347.1 5359.0 5419.0 5442.3 5218.7 5341.3 5347.1 5372.5 5378.1 4175.0 4188.0 4201.4 4251.0 4253.7 4011.2 4085.6 4087.3 4087.6 4242.3 4043.6 4062.9 4091.0 4178.2 4209.3 4206.1 4216.2 4227.2 4229.2 4234.5 3738.1 3742.2 3743.6 3747.3 3751.2 5069.9 5181.5 5185.5 5208.8 5212.8 4858.2 4871.8 4874.1 4874.8 4878.0 5659.0 5669.2 5672.0 5672.8 5679.0 3816.1 3914.6 3944.2 4025.8 4082.6 5836.4 5903.2 5937.0 5939.3 5939.7 4147.6 4169.4 4193.2 4195.9 4203.3 4249.6 4260.9 4263.1 4264.9 4269.9 4688.5 4799.1 4812.5 4818.7 4822.7 5654.1 5659.7 5661.8 5665.6 5667.4 1491.1 1510.2 1510.4 1511.6 1512.3 1037.0 1037.5 1056.5 1064.4 1065.2 4924.1 4930.5 4935.9 4936.0 4936.7 5835.2 5842.5 5846.2 5856.6 5858.6 4926.8 4928.3 4929.6 4931.6 4931.8 3084.9 3111.6 3125.1 3149.9 3153.9 5489.5 5494.3 5498.1 5502.2 5519.2 5973.3 5977.3 5984.3 5985.4 5987.0 5492.2 5493.7 5497.1 5503.8 5504.7 5660.2 5774.5 5807.6 5814.0 5827.3 5516.8 5607.4 5686.2 5715.1 5770.4 5527.8 5552.9 5560.6 5561.4 5561.4 4195.9 4197.2 4198.7 4201.1 4202.1 5721.7 5854.9 5858.2 5861.8 5863.6 5629.0 5639.7 5641.7 5643.0 5655.1 5631.3 5632.2 5634.2 5636.9 5637.7 5414.2 5514.7 5518.6 5527.6 5528.3 5662.1 5673.6 5689.9 5691.5 5695.2 5519.8 5522.8 5528.2 5530.9 5536.3 22:21:57 INFO - 2015-11-19 22:21:57,650 DEBUG : BROWSER_OUTPUT: 22:21:57 INFO - 2015-11-19 22:21:57,650 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12625.94 Median:23862.64 stddev:14720.90 (61.7%) stddev-sans-first:14734.98 22:21:57 INFO - 2015-11-19 22:21:57,651 DEBUG : BROWSER_OUTPUT: Values: 706.6 713.6 778.8 786.0 790.3 11566.8 11816.4 11950.2 11968.1 11982.2 11377.9 11474.1 11477.4 11490.1 11491.4 620.6 634.3 794.2 805.5 805.8 796.8 796.9 804.6 805.6 806.1 650.0 660.6 824.2 838.5 839.0 817.0 826.2 827.8 829.1 829.1 613.6 614.2 614.3 614.4 614.6 12090.9 12193.8 12241.1 12246.7 12282.1 11294.5 11503.6 11812.6 11975.7 12040.6 9252.9 9278.0 9339.1 9354.3 9395.3 3136.6 3196.9 3207.8 3231.0 3251.4 41506.6 41806.6 41838.6 41902.2 41946.0 9418.6 9419.6 9562.9 9641.1 9726.5 16866.6 16877.4 16892.7 16914.6 16916.8 5836.7 6121.1 6125.4 6178.9 6226.0 3319.8 3412.9 3442.5 3475.6 3537.5 2713.9 2746.8 2751.3 3003.7 3103.2 538.4 542.6 542.7 550.1 556.6 448.1 463.5 494.9 510.6 575.8 7131.9 7230.3 7307.1 7348.7 7579.2 481.7 507.0 565.8 569.2 577.7 3363.2 3489.8 3561.1 3592.7 3615.6 54202.7 54381.2 54690.5 54752.5 54812.2 47261.8 47293.3 47574.0 47855.5 47881.3 42671.6 43835.3 44100.1 44752.3 45056.8 6909.8 7073.4 7207.3 7254.2 7288.8 31887.8 32261.7 32385.4 33194.7 33288.5 37020.0 37051.0 38171.6 41846.2 42135.0 8950.3 10110.6 10149.7 10414.8 10768.4 11091.7 11261.9 11340.4 11395.9 11893.3 10682.3 10983.3 11087.3 11129.2 11470.5 10297.7 10453.4 10499.2 10510.7 10519.4 10324.9 10446.1 10491.5 10797.3 10844.9 9039.9 9190.3 9357.0 9439.9 9464.5 8860.9 9075.3 9080.5 9110.6 9283.9 22:21:57 INFO - 2015-11-19 22:21:57,651 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:57 INFO - 2015-11-19 22:21:57,651 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-19 22:21:58,239 INFO : Browser exited with error code: 0 22:21:58 INFO - 2015-11-19 22:21:58,261 INFO : Completed test dromaeo_css (00:18:37) 22:21:58 INFO - 2015-11-19 22:21:58,261 INFO : Starting test kraken 22:21:58 INFO - 2015-11-19 22:21:58,262 DEBUG : operating with platform_type : linux_ 22:21:58 INFO - 2015-11-19 22:21:58,262 INFO : Initialising browser for kraken test... 22:21:58 INFO - 2015-11-19 22:21:58,268 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHkksI/profile http://localhost:38804/getInfo.html 22:22:02 INFO - 2015-11-19 22:22:02,009 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:22:02 INFO - 2015-11-19 22:22:02,010 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:22:02 INFO - 2015-11-19 22:22:02,010 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:22:02 INFO - 2015-11-19 22:22:02,010 DEBUG : BROWSER_OUTPUT: __metrics 22:22:02 INFO - 2015-11-19 22:22:02,147 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:22:03 INFO - 2015-11-19 22:22:03,304 INFO : Browser initialized. 22:22:03 INFO - 2015-11-19 22:22:03,304 INFO : Running cycle 1/1 for kraken test... 22:22:03 INFO - 2015-11-19 22:22:03,305 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHkksI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:22:15 INFO - 2015-11-19 22:22:15,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 22:22:15 INFO - 2015-11-19 22:22:15,221 DEBUG : BROWSER_OUTPUT: 22:22:17 INFO - 2015-11-19 22:22:17,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection) 22:22:18 INFO - 2015-11-19 22:22:18,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 175529984 22:22:18 INFO - 2015-11-19 22:22:18,430 DEBUG : BROWSER_OUTPUT: 22:22:21 INFO - 2015-11-19 22:22:21,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-dft) 22:22:21 INFO - 2015-11-19 22:22:21,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 166658048 22:22:21 INFO - 2015-11-19 22:22:21,754 DEBUG : BROWSER_OUTPUT: 22:22:24 INFO - 2015-11-19 22:22:24,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-fft) 22:22:25 INFO - 2015-11-19 22:22:25,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 152006656 22:22:25 INFO - 2015-11-19 22:22:25,311 DEBUG : BROWSER_OUTPUT: 22:22:27 INFO - 2015-11-19 22:22:27,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator) 22:22:27 INFO - 2015-11-19 22:22:27,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 155365376 22:22:27 INFO - 2015-11-19 22:22:27,917 DEBUG : BROWSER_OUTPUT: 22:22:30 INFO - 2015-11-19 22:22:30,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:22:30 INFO - 2015-11-19 22:22:30,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 155803648 22:22:30 INFO - 2015-11-19 22:22:30,705 DEBUG : BROWSER_OUTPUT: 22:22:33 INFO - 2015-11-19 22:22:33,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom) 22:22:34 INFO - 2015-11-19 22:22:34,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 155369472 22:22:34 INFO - 2015-11-19 22:22:34,270 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-19 22:22:37,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate) 22:22:38 INFO - 2015-11-19 22:22:38,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 158478336 22:22:38 INFO - 2015-11-19 22:22:38,193 DEBUG : BROWSER_OUTPUT: 22:22:41 INFO - 2015-11-19 22:22:41,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial) 22:22:41 INFO - 2015-11-19 22:22:41,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 156590080 22:22:41 INFO - 2015-11-19 22:22:41,646 DEBUG : BROWSER_OUTPUT: 22:22:43 INFO - 2015-11-19 22:22:43,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:22:43 INFO - 2015-11-19 22:22:43,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 163250176 22:22:43 INFO - 2015-11-19 22:22:43,937 DEBUG : BROWSER_OUTPUT: 22:22:45 INFO - 2015-11-19 22:22:45,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:22:46 INFO - 2015-11-19 22:22:46,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 161722368 22:22:46 INFO - 2015-11-19 22:22:46,434 DEBUG : BROWSER_OUTPUT: 22:22:48 INFO - 2015-11-19 22:22:48,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:22:49 INFO - 2015-11-19 22:22:49,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 168726528 22:22:49 INFO - 2015-11-19 22:22:49,135 DEBUG : BROWSER_OUTPUT: 22:22:51 INFO - 2015-11-19 22:22:51,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:22:52 INFO - 2015-11-19 22:22:52,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 177360896 22:22:52 INFO - 2015-11-19 22:22:52,270 DEBUG : BROWSER_OUTPUT: 22:22:54 INFO - 2015-11-19 22:22:54,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:22:55 INFO - 2015-11-19 22:22:55,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 174010368 22:22:55 INFO - 2015-11-19 22:22:55,489 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38804/tests/kraken/driver.html?testName=ai-astar) 22:22:57 INFO - 2015-11-19 22:22:57,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 233185280 22:22:57 INFO - 2015-11-19 22:22:57,534 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,537 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:22:57 INFO - 2015-11-19 22:22:57,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:22:57 INFO - 2015-11-19 22:22:57,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:22:57 INFO - 2015-11-19 22:22:57,537 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;111;111;111;101;112;103;112 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;163;166;139;165;153;142;168;135 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;162;165;161;162;161;161 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;85;92;72;72;74;120;97;74 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;138;91;93;92;129;91;92;125 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;110;110;109;110 22:22:57 INFO - 2015-11-19 22:22:57,538 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;148;147;148;146;148;147;148 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;67;67;68;69;68;68;76;66;67 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;69;69;69;68;69;68 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;83;92;82;84;85;92;83 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;119;117;128;125;124;125;125;126;124 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;161;148;146;163;143;146;146;144;138 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;68;73;69;69;69;76;73;69 22:22:57 INFO - 2015-11-19 22:22:57,539 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:22:57 INFO - 2015-11-19 22:22:57,540 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:22:57 INFO - 2015-11-19 22:22:57,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 22:22:57 INFO - 2015-11-19 22:22:57,540 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:22:57 INFO - 2015-11-19 22:22:57,540 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000577535__endTimestamp 22:22:57 INFO - 2015-11-19 22:22:57,540 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 111.0 111.0 111.0 101.0 112.0 103.0 112.0 22:22:57 INFO - 2015-11-19 22:22:57,544 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.50 Median:158.00 stddev:13.91 (8.8%) stddev-sans-first:14.74 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 163.0 166.0 139.0 165.0 153.0 142.0 168.0 135.0 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 162.0 165.0 161.0 162.0 161.0 161.0 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.30 Median:74.00 stddev:15.76 (21.3%) stddev-sans-first:16.26 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 85.0 92.0 72.0 72.0 74.0 120.0 97.0 74.0 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:91.50 stddev:19.09 (20.9%) stddev-sans-first:19.79 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 138.0 91.0 93.0 92.0 129.0 91.0 92.0 125.0 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,545 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 148.0 147.0 148.0 146.0 148.0 147.0 148.0 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.00 stddev:2.80 (4.1%) stddev-sans-first:2.96 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 69.0 68.0 68.0 76.0 66.0 67.0 22:22:57 INFO - 2015-11-19 22:22:57,546 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 68.0 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:3.68 (4.4%) stddev-sans-first:3.87 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 83.0 92.0 82.0 84.0 85.0 92.0 83.0 22:22:57 INFO - 2015-11-19 22:22:57,547 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.00 stddev:3.68 (2.9%) stddev-sans-first:3.46 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: Values: 129.0 119.0 117.0 128.0 125.0 124.0 125.0 125.0 126.0 124.0 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:147.00 stddev:8.37 (5.7%) stddev-sans-first:8.26 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: Values: 158.0 161.0 148.0 146.0 163.0 143.0 146.0 146.0 144.0 138.0 22:22:57 INFO - 2015-11-19 22:22:57,548 DEBUG : BROWSER_OUTPUT: 22:22:57 INFO - 2015-11-19 22:22:57,549 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.50 stddev:2.67 (3.8%) stddev-sans-first:2.83 22:22:57 INFO - 2015-11-19 22:22:57,549 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 68.0 73.0 69.0 69.0 69.0 76.0 73.0 69.0 22:22:57 INFO - 2015-11-19 22:22:57,549 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:22:57 INFO - 2015-11-19 22:22:57,549 DEBUG : BROWSER_OUTPUT: 22:22:58 INFO - 2015-11-19 22:22:58,421 INFO : Browser exited with error code: 0 22:22:58 INFO - 2015-11-19 22:22:58,472 INFO : Completed test kraken (00:01:00) 22:22:58 INFO - 2015-11-19 22:22:58,472 INFO : Starting test v8_7 22:22:58 INFO - 2015-11-19 22:22:58,472 DEBUG : operating with platform_type : linux_ 22:22:58 INFO - 2015-11-19 22:22:58,472 INFO : Initialising browser for v8_7 test... 22:22:58 INFO - 2015-11-19 22:22:58,478 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82vT0G/profile http://localhost:38804/getInfo.html 22:23:02 INFO - 2015-11-19 22:23:02,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:23:02 INFO - 2015-11-19 22:23:02,292 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:23:02 INFO - 2015-11-19 22:23:02,292 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:23:02 INFO - 2015-11-19 22:23:02,292 DEBUG : BROWSER_OUTPUT: __metrics 22:23:02 INFO - 2015-11-19 22:23:02,408 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:23:03 INFO - 2015-11-19 22:23:03,647 INFO : Browser initialized. 22:23:03 INFO - 2015-11-19 22:23:03,647 INFO : Running cycle 1/1 for v8_7 test... 22:23:03 INFO - 2015-11-19 22:23:03,647 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82vT0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:23:15 INFO - 2015-11-19 22:23:15,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 142315520 22:23:15 INFO - 2015-11-19 22:23:15,568 DEBUG : BROWSER_OUTPUT: 22:23:36 INFO - 2015-11-19 22:23:36,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38804/tests/v8_7/run.html (next: http://localhost:38804/tests/v8_7/run.html) 22:23:37 INFO - 2015-11-19 22:23:37,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 444157952 22:23:37 INFO - 2015-11-19 22:23:37,241 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,242 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:23:37 INFO - 2015-11-19 22:23:37,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:23:37 INFO - 2015-11-19 22:23:37,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:23:37 INFO - 2015-11-19 22:23:37,243 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:23:37 INFO - 2015-11-19 22:23:37,243 DEBUG : BROWSER_OUTPUT: |0;Richards;162.91951775822744 22:23:37 INFO - 2015-11-19 22:23:37,243 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.60758766047135 22:23:37 INFO - 2015-11-19 22:23:37,244 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 22:23:37 INFO - 2015-11-19 22:23:37,244 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:23:37 INFO - 2015-11-19 22:23:37,244 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2134.3283582089553 22:23:37 INFO - 2015-11-19 22:23:37,244 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 22:23:37 INFO - 2015-11-19 22:23:37,244 DEBUG : BROWSER_OUTPUT: |6;Boyer;11847.058823529413 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: |8;Splay;607.90273556231 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000617241__endTimestamp 22:23:37 INFO - 2015-11-19 22:23:37,245 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.92 Median:162.92 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: Values: 162.9 22:23:37 INFO - 2015-11-19 22:23:37,246 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,247 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,247 DEBUG : BROWSER_OUTPUT: Values: 191.6 22:23:37 INFO - 2015-11-19 22:23:37,247 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,248 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,248 DEBUG : BROWSER_OUTPUT: Values: 279.1 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2134.33 Median:2134.33 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: Values: 2134.3 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,249 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: Values: 787.4 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11847.06 Median:11847.06 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: Values: 11847.1 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,250 DEBUG : BROWSER_OUTPUT: Values: 26710.5 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: Values: 607.9 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: Values: 4845.4 22:23:37 INFO - 2015-11-19 22:23:37,251 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:23:37 INFO - 2015-11-19 22:23:37,252 DEBUG : BROWSER_OUTPUT: 22:23:38 INFO - 2015-11-19 22:23:38,141 INFO : Browser exited with error code: 0 22:23:38 INFO - 2015-11-19 22:23:38,158 INFO : Completed test v8_7 (00:00:39) 22:23:38 INFO - 2015-11-19 22:23:38,271 INFO : Completed test suite (00:20:17) 22:23:38 INFO - 2015-11-19 22:23:38,271 DEBUG : Working with test: dromaeo_css 22:23:38 INFO - 2015-11-19 22:23:38,271 DEBUG : Generating results file: dromaeo_css 22:23:38 INFO - 2015-11-19 22:23:38,272 DEBUG : Working with test: kraken 22:23:38 INFO - 2015-11-19 22:23:38,272 DEBUG : Generating results file: kraken 22:23:38 INFO - 2015-11-19 22:23:38,273 INFO : javascript benchmark 22:23:38 INFO - 2015-11-19 22:23:38,273 DEBUG : Working with test: v8_7 22:23:38 INFO - 2015-11-19 22:23:38,273 DEBUG : Generating results file: v8_7 22:23:38 INFO - 2015-11-19 22:23:38,273 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:23:38 INFO - 2015-11-19 22:23:38,331 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 22:23:38 INFO - 2015-11-19 22:23:38,331 DEBUG : process_Request line: dromaeo_css 6490.32 graph.html#tests=[[72,94,35]] 22:23:38 INFO - 2015-11-19 22:23:38,331 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:23:38 INFO - 2015-11-19 22:23:38,361 DEBUG : process_Request line: kraken 1526.90 graph.html#tests=[[232,94,35]] 22:23:38 INFO - 2015-11-19 22:23:38,361 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:23:38 INFO - 2015-11-19 22:23:38,389 DEBUG : process_Request line: v8_7 19754.99 graph.html#tests=[[230,94,35]] 22:23:38 INFO - 2015-11-19 22:23:38,391 INFO : javascript benchmark 22:23:38 INFO - 2015-11-19 22:23:38,393 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.4373181631854, 2743.8353698778074, 2747.120921305183, 2757.255541003929, 2771.972280277197, 4570.1316749817515, 4714.434267887849, 4720.268358404449, 4757.857264282068, 4768.90462190756, 4731.290306454025, 4742.33607294979, 4774.188387974044, 4814.205656066745, 4818.397700287464, 4225.231238676453, 4370.060437006043, 4481.2381895077915, 4501.347304640825, 4512.796924138422, 4314.784260786948, 4486.484054333744, 4509.661775366844, 4544.522825103366, 4552.8634140975655, 4251.6173544380845, 4332.675049371278, 4354.042110735633, 4367.039251364695, 4375.606195442426, 4423.203823311803, 4426.203283408985, 4432.157890000922, 4433.224185767478, 4468.597826195625, 4393.714408563465, 4410.4927933287445, 4415.580519850609, 4456.821727130911, 4470.977645111786, 4569.794359253841, 4597.586217240431, 4720.716756994591, 4721.079389519045, 4739.64452666048, 5121.795128194868, 5154.561862241714, 5162.948370516285, 5164.0, 5176.145935920568, 5185.533302002837, 5186.896262074775, 5192.1692529195525, 5232.947670523284, 5236.21456781482, 4693.13177062248, 4703.294505824086, 4808.9519104808505, 4810.759462026885, 4815.542523460265, 5300.9734951325, 5342.2253773202665, 5345.224942383333, 5350.5184533392185, 5398.379186393537, 5100.923486147711, 5130.179171332569, 5133.358330208724, 5133.563647090039, 5185.248139019821, 4938.987507560942, 4998.625103117281, 5073.720945348041, 5107.0, 5108.106081435734, 5016.749162541858, 5028.396592408934, 5033.496650334937, 5037.0681423936685, 5083.87290317745, 4998.850034498971, 5003.449620541737, 5008.248762685554, 5009.5491405773655, 5015.272785446163, 4065.5121385433936, 4093.058596522757, 4150.107726838744, 4195.160967806451, 4195.7692326922315, 3749.1189570450924, 3761.605031471711, 3771.9811400943368, 3782.5650050244576, 3816.0269131371324, 4459.576340247671, 4465.397171381886, 4467.106578684211, 4492.303692927601, 4510.909781804411, 4979.327790748275, 5088.949110508847, 5100.132977393852, 5248.160294352885, 5250.579953603703, 4331.047169622678, 4333.025069359369, 4380.671449641226, 4400.361947517656, 4406.052698669801, 4564.383808185852, 4567.018091110427, 4583.449986001701, 4599.172149013143, 4608.723476591415, 4695.272232803921, 4932.8766780830765, 4934.7285899275885, 4941.827036053721, 4944.579710724557, 5058.64589478733, 5088.465711100281, 5113.3097031900215, 5147.485251474823, 5199.038177936943, 4874.195757699939, 4898.020395920759, 4907.2393778964315, 4911.926321105258, 4915.778789954532, 4867.732274724783, 5080.872978175576, 5082.415522214993, 5085.237214417867, 5100.923486147636, 4985.052839960396, 5059.696418214919, 5081.33942587476, 5202.843914682566, 5210.47895210476, 4999.425066117297, 5002.674826136289, 5009.799608015638, 5020.221865610836, 5051.06555287273, 4787.210110331756, 5001.749912504433, 5023.974880125722, 5027.622928280321, 5040.8991820162655, 4808.08646357191, 4857.0, 4860.441049279378, 4874.975625121851, 4893.21708526634, 5039.722815245197, 5075.162598171408, 5075.441701412916, 5085.3134826797905, 5086.720230387365, 4938.0, 4941.752912354296, 4945.1346014448045, 4946.62900282473, 4983.825566105169], "unit": "ms", "name": "dojo.html", "value": 4699.588793198146}, {"lowerIsBetter": false, "replicates": [557.5595279729014, 572.1932075773159, 574.4112284907969, 576.8327185116314, 579.3829571506348, 28329.716702832964, 28701.856490717542, 34210.48684269735, 34254.65745342546, 34443.48334774974, 37450.43824342637, 37887.0, 37974.62025379745, 37996.0, 38056.0, 7850.293473587376, 8004.799880002988, 8028.598570071502, 8035.397345199104, 8041.959790201041, 7229.277072292755, 7427.14587822402, 9938.602455901755, 10135.797284054315, 10161.644342448017, 10042.849357259647, 10117.291789574732, 10156.94921525395, 10161.54273057714, 10166.491675416237, 7090.858182836366, 7236.276372362721, 10006.59973601055, 10133.189344852393, 10137.138343240797, 9986.450745209011, 10254.0, 10260.435676037814, 10262.640807571774, 10263.230257730625, 37636.0, 38136.42795358072, 38165.61834381648, 38175.23649527022, 38180.80909595462, 2932.780041496896, 2968.7921845470823, 2973.36072744361, 2979.463696534623, 3471.2710330830555, 27869.72130278712, 28179.51157627638, 28222.0, 28428.147155585364, 28661.713382866114, 3328.107325011415, 3363.209645733251, 3379.3410284994434, 3471.5139880416764, 3512.824358782076, 222615.0, 224462.0, 224603.0, 224757.0, 225211.0, 46957.530424696, 47796.761016194694, 55776.0, 61308.69345653243, 63017.0, 56352.71823640855, 56468.0, 56641.716791415776, 56657.71671141618, 56684.716576417675, 13831.79252311216, 13912.860871391358, 13922.582322530341, 13951.930240348733, 13975.09161904473, 10685.732856678645, 10694.35833849956, 10709.518071686793, 10719.83920241197, 10894.67315980522, 18785.15466803997, 18837.90581047086, 18839.340623078126, 18936.81063189378, 18963.715544266848, 6976.651167441709, 7265.455090868206, 7267.563946163247, 7308.269173082649, 7402.370798482081, 826.4256341842362, 868.1318681318681, 869.686912711436, 887.5562218890555, 924.3483344242293, 26423.73576264251, 26657.73342266591, 27157.321066973087, 27204.319892002462, 27266.863665681543, 926.8470702334174, 986.9358491698017, 999.4752754803786, 1098.357460885375, 1115.1413411672966, 13881.4447422104, 13922.651933701536, 14040.578782636538, 14047.719045619031, 14123.78814317786, 251996.0, 253611.0, 254387.0, 256316.0, 258021.0, 46719.0, 47015.529844701116, 47056.5294347059, 47188.7640561795, 47247.527524725, 1051.984220236697, 1064.0742553978089, 1102.2064113838023, 1194.611751180887, 1201.3272567362305, 23742.852295747638, 26042.34894127662, 27260.591091133254, 27294.590581140903, 27360.726392735818, 36516.26967460689, 37245.627543724215, 41869.58130418657, 42693.35959960665, 42722.78638606787, 317268.0, 320763.0, 322897.0, 323073.0, 323389.0, 28379.290517737223, 28767.42465150727, 28802.0, 28804.567931481462, 28821.0, 39083.21833563256, 40070.79964600275, 40113.0, 40170.39744403895, 40972.38541421822, 33782.0, 34031.0, 34727.13182170466, 34997.65002349944, 35367.0, 31068.0, 32781.344373111926, 33105.33789324248, 33772.831135844164, 33791.662083378855, 30651.0, 33591.83204083964, 34062.48906266457, 34066.65933340635, 34198.14504637404, 26200.8689956549, 29723.55414668825, 29747.702522974494, 30503.847480762455, 30763.846180768953, 23137.190198342978, 23282.41793955097, 23736.762632373455, 23765.762342376354, 23982.640260395758], "unit": "ms", "name": "ext.html", "value": 17267.2672001171}, {"lowerIsBetter": false, "replicates": [341.2271205719046, 341.7641827139274, 343.0565943654949, 344.1997356146957, 351.9841607127679, 12504.374781260924, 12917.031222658292, 14734.926325368371, 15013.249337533121, 16661.83338166618, 15994.76007859883, 16054.277557509911, 16364.427245046425, 16380.918095409506, 16397.18014099296, 4788.736619485936, 5125.513076257768, 5131.846044618667, 5132.871678208056, 5133.640645154841, 3554.4668299754985, 3627.147620309225, 3627.9455808162897, 5039.370078740158, 5596.692181929992, 5757.856053598652, 5767.509761670242, 5789.594728369016, 5796.478316951474, 5797.072468405056, 5577.553795696354, 5794.217780599628, 5798.043322851746, 5798.333191682926, 5803.767849286023, 5166.380034395859, 5176.171812509981, 5183.341330774154, 5184.9740751296, 5194.142966410538, 19994.0, 20638.793612063986, 20862.374128776162, 21532.677009844865, 22127.114915403527, 1953.8339241164517, 1985.1860737097866, 2008.1666108564928, 2012.0342235726932, 2017.6569983102909, 13545.45818167272, 13771.380287887068, 13889.166650001032, 14089.154650720888, 14480.0, 1881.9717704234447, 1888.8205620466172, 1918.7313776071362, 1959.480737604536, 1978.3669225847734, 50822.7458862707, 62773.686131569506, 66209.66895165494, 66392.3360766391, 66726.3327366725, 15658.0, 15659.217039147998, 15725.764113538306, 15791.684166316609, 15810.446634367972, 23285.7671423287, 23298.65052024221, 23572.64641030386, 23598.882005590207, 23631.645525317133, 8700.956495217484, 8867.600957956907, 8902.510361930026, 8946.418482798597, 8979.551022448852, 7478.588677622674, 7559.811004724926, 7584.5070070446345, 7634.198409166957, 7646.732364367221, 7593.962030189924, 7657.157712651604, 7665.0, 7707.383409327241, 7733.7679869604, 1766.5053784940237, 1769.301126055201, 1803.6753384390936, 1833.2208811255164, 2166.9891650541645, 826.2068414322318, 876.2639382918252, 928.8746019287445, 961.8028304197622, 965.6909788867495, 15858.365665373487, 16275.593110172103, 16291.511254662379, 16385.0, 16584.917075414545, 817.4196320612432, 832.7168762620738, 854.747849384433, 894.494610545053, 930.5207817973749, 7549.73575924851, 8473.95763021181, 9168.633254669872, 9403.29475289356, 9424.528773561295, 439730.0, 452085.0, 453205.0, 455545.0, 461221.0, 70837.0, 71421.42892855336, 72938.63530682419, 73123.26876731271, 74119.62940185264, 1043.9060484556273, 1053.1311667874033, 1053.2364036073784, 1058.0001898206121, 1059.3220338983058, 14715.337809798371, 14838.40646374133, 14960.925195373953, 15083.698326033198, 15117.470888518848, 31713.365732684757, 32342.83828580842, 32741.0, 32908.67091329056, 32912.0, 40665.186696265315, 42211.1557768849, 42230.577694222666, 42671.786641066596, 42714.0, 8709.477431354138, 9177.311701622271, 9302.116298951589, 9432.103950124727, 9435.24518038569, 10437.530311136168, 13575.728485430434, 16706.164691765607, 17093.316267349663, 17210.225539850486, 13816.58550243454, 13820.930895345458, 14038.087524310888, 14191.148531088167, 14731.0, 12945.09384343087, 13095.148815327355, 13126.081174317706, 13408.731825363244, 13409.865901340861, 13077.0, 13356.198628082346, 14113.858861411254, 14727.779083313973, 14858.108513489226, 8158.265756081981, 8213.301869341172, 8258.917410826056, 8303.501789892625, 8359.164083591835, 10270.794584108426, 11699.766004680028, 13530.79703804424, 13647.317634118453, 13957.441702331793], "unit": "ms", "name": "jquery.html", "value": 9004.21642738368}, {"lowerIsBetter": false, "replicates": [1272.9236245825246, 1657.7844880165578, 1702.157432071125, 1718.957026074348, 1737.83490568396, 6320.683965801709, 6913.101296831411, 7171.497995140342, 7176.461765367592, 7193.676284567187, 6973.616451095188, 7080.822979425517, 7087.468439867018, 7136.536125151862, 7177.28227177282, 1811.9637607247846, 1861.4415675297357, 2053.917843286274, 2111.229401268541, 2137.1344605434824, 2171.8045375916163, 2182.4871155278497, 2184.3446965910243, 2184.945376365588, 2185.748638906522, 2077.439091445309, 2117.5235571996254, 2127.8297736181066, 2128.5530038691895, 2130.360891732482, 1780.97328540072, 1816.582186097205, 2034.745656792901, 2100.0339843671777, 2100.56938327644, 2111.2082968886666, 2112.8098471137673, 2123.3417640531484, 2135.0925856511076, 2138.6257404954226, 7192.892106618405, 7238.963805180941, 7247.528910620793, 7275.1633562140505, 7281.1262648482525, 4369.6722745794195, 4455.487618923833, 4470.776461176928, 4479.462464504248, 4485.372047913294, 2869.727375899286, 2883.610712553799, 2917.737403633662, 2933.457310397583, 3022.123584160591, 881.9823603527893, 897.5108565831638, 910.6493999810054, 913.0960349254191, 918.6345210578158, 9979.101880830687, 9991.900080999243, 10003.049710277512, 10021.549030293581, 10025.047620476043, 4034.3948407738485, 4089.734167279117, 4140.130572579792, 4147.647449966787, 4179.665626749914, 8473.872891906627, 8507.234348908629, 8517.148285171557, 8533.44532605391, 8535.701250456204, 4455.6212721918355, 4462.0, 4466.084452687256, 4466.6873318867365, 4470.463544374696, 3990.341593637075, 4044.737092089005, 4047.7571345719352, 4051.2707712611423, 4054.8378064877074, 3524.524189234472, 3526.0655926179584, 3547.450145227494, 3552.4848896909803, 3575.7496975212007, 1125.926814757038, 1128.368113856243, 1143.2911594811271, 1157.3518829455531, 1160.0545555372344, 879.9824003519893, 976.3751199232497, 1153.2676750263643, 1170.5142365918048, 1182.3260741377333, 6092.786752463642, 6928.584284942919, 7084.787456376317, 7095.538789978635, 7100.218975912646, 929.1730359979623, 932.7994481186441, 996.3374356053143, 1006.4917216805467, 1049.8320268757116, 5315.6279060465395, 5430.619856609999, 5490.0941344677685, 5494.423085575957, 5501.504864562208, 8709.433886797338, 8798.912010879938, 8810.383273170817, 8880.8667869982, 8915.55422228886, 8448.57757112142, 8723.171298726611, 8774.34192435557, 8784.60469278884, 8806.823863522823, 6882.552634078769, 6923.0, 6931.896021559681, 6975.441964642816, 6978.883378659491, 6644.136262286065, 6677.699503522256, 6689.063531105747, 6694.163229596301, 6715.697793599397, 7748.806279842824, 7864.21357864209, 7868.095169055403, 7871.33093687043, 7921.643526041457, 8010.3992200584025, 8045.477043992122, 8126.390520710852, 8160.224778646019, 8183.754487365389, 6374.29882712892, 6445.097686324012, 6446.484281257582, 6450.387213214737, 6457.644829534421, 6860.0, 6917.654117294216, 6929.896051559332, 6933.0986971693355, 6937.132858392701, 6193.349698281616, 6284.057391391328, 6330.177076979963, 6435.806925792233, 6460.289368169404, 6229.937700622936, 6269.12232287471, 6311.810645680637, 6335.208098987627, 6432.6462044588, 5780.335261444988, 5898.528117750484, 5903.675297858659, 6476.060971159061, 6509.316521765147, 5363.19552067193, 6101.054336577838, 6108.08378743192, 6123.663198524124, 6126.0, 5913.319968203712, 5945.881082378415, 5958.672273024852, 5960.046392577166, 5962.850928726816], "unit": "ms", "name": "mootools.html", "value": 4181.133782721542}, {"lowerIsBetter": false, "replicates": [306.4759261662557, 307.31928777757264, 311.3384058874891, 311.86278037663425, 316.77825522134503, 5253.8949221015555, 5347.0909945309295, 5358.973205133979, 5419.0245755764, 5442.319710036246, 5218.660787048839, 5341.30563026807, 5347.144456886899, 5372.489613486712, 5378.112611419121, 4174.958250417495, 4188.0, 4201.39079833424, 4250.979764856427, 4253.680973926952, 4011.237864805692, 4085.55058943516, 4087.3460246360587, 4087.591240875918, 4242.300020496615, 4043.5956404359476, 4062.8984275393204, 4090.9590904090874, 4178.247915375231, 4209.284421648327, 4206.116715489751, 4216.198922204787, 4227.175700738358, 4229.238737027334, 4234.513031001444, 3738.140227747606, 3742.2328422673286, 3743.5882052974152, 3747.269282489888, 3751.174741556853, 5069.923951140736, 5181.455947125535, 5185.533302002837, 5208.817691380821, 5212.817551385721, 4858.174110401205, 4871.8294859679745, 4874.098291816025, 4874.7562621868765, 4878.048780487807, 5659.0, 5669.177969194485, 5672.035753921843, 5672.801451949162, 5679.0, 3816.0650640592953, 3914.628110329514, 3944.1914407546383, 4025.75845449274, 4082.5509193988933, 5836.38717934615, 5903.173555702248, 5936.97031514844, 5939.316978547436, 5939.732712027969, 4147.605977432139, 4169.395437661522, 4193.22425351311, 4195.853145139906, 4203.327467605169, 4249.638780703613, 4260.893477663083, 4263.126059157865, 4264.87205383839, 4269.893252668646, 4688.46082700487, 4799.136155492045, 4812.51874812523, 4818.71087734737, 4822.71063736177, 5654.123610840326, 5659.660420374791, 5661.7735290588735, 5665.631733937281, 5667.376588575254, 1491.0904348347499, 1510.2448775612195, 1510.4260381055349, 1511.6470758670928, 1512.3043400036106, 1037.040737317993, 1037.5019990404496, 1056.4612047855649, 1064.387976913278, 1065.1532032034552, 4924.079608952511, 4930.506949305112, 4935.925961110586, 4935.950640493621, 4936.703797772145, 5835.2122463466885, 5842.532597392198, 5846.1523079153285, 5856.619319744203, 5858.619189752738, 4926.802927882916, 4928.310036594879, 4929.556339929423, 4931.630127740434, 4931.778069986859, 3084.922876928095, 3111.6110486189227, 3125.140586338775, 3149.9055028349185, 3153.8896138635037, 5489.533389661923, 5494.2857428534035, 5498.092814685612, 5502.174673798962, 5519.172124181405, 5973.342932277446, 5977.282726072899, 5984.3417224105315, 5985.40145985398, 5987.0, 5492.231087647732, 5493.697846618395, 5497.147942068986, 5503.834884953378, 5504.724763761796, 5660.179274005329, 5774.538036957118, 5807.564432667651, 5813.970930145322, 5827.329857066492, 5516.806911758069, 5607.41122182165, 5686.175504551899, 5715.114157305624, 5770.422957704196, 5527.806526771544, 5552.916706249491, 5560.638558493685, 5561.416051314553, 5561.443855614406, 4195.930037840331, 4197.202531519001, 4198.706090573631, 4201.096764195712, 4202.138561594805, 5721.656700597978, 5854.882902342015, 5858.150568167677, 5861.765529378948, 5863.589548731718, 5628.958642651122, 5639.7180140993605, 5641.689707066151, 5643.0, 5655.066913959151, 5631.267935168402, 5632.155176723524, 5634.197056941739, 5636.859078522905, 5637.746301416528, 5414.160805075219, 5514.724263786715, 5518.586106042143, 5527.640703354269, 5528.308961379827, 5662.065759149694, 5673.574481913791, 5689.914651280317, 5691.4877661010705, 5695.231143795535, 5519.779208831602, 5522.779088836563, 5528.226048353154, 5530.86172845666, 5536.307961504812], "unit": "ms", "name": "prototype.html", "value": 4271.940834561115}, {"lowerIsBetter": false, "replicates": [706.5689929143225, 713.6253466929858, 778.7780482562471, 785.9685612575497, 790.257158271225, 11566.768664626712, 11816.350100744456, 11950.163488555794, 11968.102392320588, 11982.161248712593, 11377.943110284437, 11474.139439542027, 11477.426128693574, 11490.138239632019, 11491.367974761406, 620.5625034350783, 634.3371177119898, 794.2018271637025, 805.5126648377735, 805.8468890910708, 796.7968168117122, 796.9043714754208, 804.5816175588691, 805.5972013993004, 806.0730160315654, 649.9837504062389, 660.5508254387015, 824.1881746479713, 838.5178522349643, 839.0267289943666, 817.0195765081926, 826.2109685250572, 827.755812035448, 829.0755807274905, 829.1128492513013, 613.5980932489226, 614.2260751453201, 614.3150387318153, 614.3764079459353, 614.6097228260087, 12090.939545302217, 12193.817092743617, 12241.143119981605, 12246.693832654166, 12282.14025018249, 11294.548218071268, 11503.597374091867, 11812.586559470463, 11975.700607484796, 12040.638780836502, 9252.907470925273, 9277.953610231905, 9339.066093390675, 9354.345195836295, 9395.34232603718, 3136.575220362493, 3196.856141473639, 3207.7914935529116, 3230.951535726966, 3251.382237374915, 41506.584934150575, 41806.581934180875, 41838.58161418377, 41902.161956760996, 41946.0, 9418.62325506972, 9419.576119074658, 9562.904370956341, 9641.084097010773, 9726.513674316257, 16866.578335541464, 16877.40929067477, 16892.662146756997, 16914.577135571708, 16916.830831691772, 5836.678982655994, 6121.081837724377, 6125.448709616156, 6178.938210617926, 6226.0, 3319.817410042471, 3412.931741365159, 3442.4664177052596, 3475.6176820549717, 3537.4870643756512, 2713.945721085567, 2746.8214566053543, 2751.3259251483514, 3003.6695963444004, 3103.1931697758296, 538.4050624060435, 542.5984771269311, 542.7449098923499, 550.1307933465115, 556.6326224691684, 448.06578284277, 463.5202565344852, 494.94803045679686, 510.5787725126711, 575.7725698349212, 7131.89302160468, 7230.349268565854, 7307.086614173229, 7348.742794002184, 7579.204183560757, 481.6941242311158, 507.02995544883476, 565.7878295639135, 569.2400645138704, 577.656294504769, 3363.226457914693, 3489.8255087246043, 3561.14269851737, 3592.7485076044427, 3615.6022837487853, 54202.728986354814, 54381.1842822358, 54690.45309546933, 54752.45247547473, 54812.17781733277, 47261.763691181324, 47293.29060064102, 47574.0, 47855.5214447851, 47881.281780773315, 42671.57328426738, 43835.34246986234, 44100.11799764051, 44752.3287150693, 45056.77471612621, 6909.827254318682, 7073.434125269863, 7207.315305046012, 7254.202037775946, 7288.760017079937, 31887.840560797977, 32261.677383225866, 32385.35229295448, 33194.66805331916, 33288.500672490416, 37020.0, 37051.0, 38171.61828381681, 41846.163076737685, 42135.0, 8950.283977281671, 10110.646127385506, 10149.695509134443, 10414.791704166026, 10768.40773757451, 11091.722706932069, 11261.943690281496, 11340.376279304717, 11395.943020284845, 11893.345865977455, 10682.252242342962, 10983.340999540053, 11087.279326843729, 11129.220954533428, 11470.483828227916, 10297.691069267934, 10453.425061621683, 10499.160067194758, 10510.737231569272, 10519.421431821323, 10324.948375258076, 10446.05985461312, 10491.527881245514, 10797.29817561856, 10844.891551084389, 9039.864402033843, 9190.31072669539, 9356.95321523388, 9439.858402123837, 9464.479453630116, 8860.911390886267, 9075.273978081606, 9080.500572468314, 9110.635574576943, 9283.907160928304], "unit": "ms", "name": "yui.html", "value": 5726.658616998157}], "name": "dromaeo_css", "value": 6490.317479556894}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 111.0, 111.0, 111.0, 101.0, 112.0, 103.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 163.0, 166.0, 139.0, 165.0, 153.0, 142.0, 168.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 165.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 85.0, 92.0, 72.0, 72.0, 74.0, 120.0, 97.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 138.0, 91.0, 93.0, 92.0, 129.0, 91.0, 92.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 103.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 148.0, 147.0, 148.0, 146.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 76.0, 66.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 83.0, 92.0, 82.0, 84.0, 85.0, 92.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 117.0, 128.0, 125.0, 124.0, 125.0, 125.0, 126.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [158.0, 161.0, 148.0, 146.0, 163.0, 143.0, 146.0, 146.0, 144.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 73.0, 69.0, 69.0, 69.0, 76.0, 73.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1526.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.91951775822744], "unit": "score", "name": "Richards", "value": 216.6836759999999}, {"lowerIsBetter": false, "replicates": [191.60758766047135], "unit": "score", "name": "DeltaBlue", "value": 345.06984200000005}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [2134.3283582089553], "unit": "score", "name": "RayTrace", "value": 346.7081328671329}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [11847.058823529413], "unit": "score", "name": "Boyer", "value": 56.255566037735804}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19754.988263470445}]} 22:23:38 INFO - RETURN: dromaeo_css: 6490.32 22:23:38 INFO - RETURN: kraken: 1526.90 22:23:38 INFO - RETURN: v8_7: 19754.99 22:23:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19754.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6490.32"}}} 22:23:38 INFO - Return code: 0 22:23:38 INFO - # TBPL SUCCESS # 22:23:38 INFO - Running post-action listener: _resource_record_post_action 22:23:38 INFO - Running post-run listener: _resource_record_post_run 22:23:39 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512077824; Read time: 28; Write time: 463476 22:23:39 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 222986240; Read time: 0; Write time: 298372 22:23:39 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 289079296; Read time: 0; Write time: 165104 22:23:39 INFO - Running post-run listener: _upload_blobber_files 22:23:39 INFO - Blob upload gear active. 22:23:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:23:39 INFO - Copying logs to upload dir... 22:23:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.376201 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-19 22:23:38.535627) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:23:38.539502) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010101 build_url: 'https://queue.taskcluster.net/v1/task/8lMdDzBPRgevcJGbcutB5A/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-19 22:23:38.593743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:23:38.594158) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447998148.658118-134795105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:23:38.643972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:23:38.644286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:23:38.644574) ========= ========= Total master_lag: 0.20 =========