builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1453205596.04 results: success (0) buildid: 20160119025837 builduid: aa9387642a9c4a4e9b8f228f92f95760 revision: 939a20ef46ea94c7ba92b1113382869d7163e06f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.043733) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.044331) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.044631) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006439 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.074662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.075000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.105312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.106007) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.156212) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.156479) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.156893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.157162) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 04:13:16-- 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% 39.6M=0s 2016-01-19 04:13:16 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.353810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.354115) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.403718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:16.404110) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 939a20ef46ea94c7ba92b1113382869d7163e06f --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 939a20ef46ea94c7ba92b1113382869d7163e06f --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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 04:13:16,699 truncating revision to first 12 chars 2016-01-19 04:13:16,699 Setting DEBUG logging. 2016-01-19 04:13:16,699 attempt 1/10 2016-01-19 04:13:16,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/939a20ef46ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 04:13:16,957 unpacking tar archive at: mozilla-central-939a20ef46ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.035811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.036170) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004659 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.087616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.087963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.098159) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.098681) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:13:17.099259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-19 04:13:17.099570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --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', '--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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:17 INFO - MultiFileLogger online at 20160119 04:13:17 in /builds/slave/test 04:13:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:17 INFO - {'append_to_log': False, 04:13:17 INFO - 'base_work_dir': '/builds/slave/test', 04:13:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:17 INFO - 'branch': 'Firefox-Non-PGO', 04:13:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:17 INFO - 'config_files': ('talos/linux_config.py',), 04:13:17 INFO - 'default_actions': ('clobber', 04:13:17 INFO - 'read-buildbot-config', 04:13:17 INFO - 'download-and-extract', 04:13:17 INFO - 'populate-webroot', 04:13:17 INFO - 'create-virtualenv', 04:13:17 INFO - 'install', 04:13:17 INFO - 'run-tests'), 04:13:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:17 INFO - 'download_minidump_stackwalk': True, 04:13:17 INFO - 'download_symbols': 'ondemand', 04:13:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:17 INFO - 'installer_path': 'installer.exe', 04:13:17 INFO - 'log_level': 'info', 04:13:17 INFO - 'log_name': 'talos', 04:13:17 INFO - 'log_to_console': True, 04:13:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:17 INFO - 'opt_config_files': (), 04:13:17 INFO - 'pip_index': False, 04:13:17 INFO - 'sps_profile': False, 04:13:17 INFO - 'sps_profile_interval': 0, 04:13:17 INFO - 'suite': 'dromaeojs', 04:13:17 INFO - 'system_bits': '32', 04:13:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:17 INFO - 'title': 'talos-linux64-ix-017', 04:13:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:17 INFO - 'use_talos_json': True, 04:13:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:17 INFO - 'work_dir': 'build'} 04:13:17 INFO - ##### 04:13:17 INFO - ##### Running clobber step. 04:13:17 INFO - ##### 04:13:17 INFO - Running pre-action listener: _resource_record_pre_action 04:13:17 INFO - Running main action method: clobber 04:13:17 INFO - rmtree: /builds/slave/test/build 04:13:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:18 INFO - Running post-action listener: _resource_record_post_action 04:13:18 INFO - ##### 04:13:18 INFO - ##### Running read-buildbot-config step. 04:13:18 INFO - ##### 04:13:18 INFO - Running pre-action listener: _resource_record_pre_action 04:13:18 INFO - Running main action method: read_buildbot_config 04:13:18 INFO - Using buildbot properties: 04:13:18 INFO - { 04:13:18 INFO - "project": "", 04:13:18 INFO - "product": "firefox", 04:13:18 INFO - "script_repo_revision": "production", 04:13:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:13:18 INFO - "repository": "", 04:13:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:13:18 INFO - "buildid": "20160119025837", 04:13:18 INFO - "pgo_build": "False", 04:13:18 INFO - "basedir": "/builds/slave/test", 04:13:18 INFO - "buildnumber": 261, 04:13:18 INFO - "slavename": "talos-linux64-ix-017", 04:13:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:13:18 INFO - "platform": "ubuntu64_hw", 04:13:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:18 INFO - "branch": "mozilla-central", 04:13:18 INFO - "repo_path": "mozilla-central", 04:13:18 INFO - "revision": "939a20ef46ea94c7ba92b1113382869d7163e06f", 04:13:18 INFO - "stage_platform": "linux64", 04:13:18 INFO - "builduid": "aa9387642a9c4a4e9b8f228f92f95760", 04:13:18 INFO - "slavebuilddir": "test" 04:13:18 INFO - } 04:13:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:13:18 INFO - Running post-action listener: _resource_record_post_action 04:13:18 INFO - ##### 04:13:18 INFO - ##### Running download-and-extract step. 04:13:18 INFO - ##### 04:13:18 INFO - Running pre-action listener: _resource_record_pre_action 04:13:18 INFO - Running main action method: download_and_extract 04:13:18 INFO - mkdir: /builds/slave/test/build/tests 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/test_packages.json 04:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/test_packages.json 04:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:24 INFO - Downloaded 1448 bytes. 04:13:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:24 INFO - Using the following test package requirements: 04:13:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:24 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'jsshell-linux-x86_64.zip'], 04:13:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:24 INFO - https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:32 INFO - Downloaded 21215629 bytes. 04:13:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:33 INFO - Return code: 0 04:13:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:33 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')]} 04:13:33 INFO - https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:35 INFO - Downloaded 21215629 bytes. 04:13:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:36 INFO - Return code: 0 04:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:36 INFO - https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:37 INFO - Downloaded 11132144 bytes. 04:13:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:13:38 INFO - Return code: 0 04:13: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')]} 04:13:38 INFO - https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:39 INFO - Downloaded 54179072 bytes. 04:13:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:39 INFO - mkdir: /builds/slave/test/properties 04:13:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:39 INFO - Contents: 04:13:39 INFO - build_url:https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - Running post-action listener: set_extra_try_arguments 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running populate-webroot step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: populate_webroot 04:13:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:39 INFO - '--tppagecycles', 04:13:39 INFO - '7'], 04:13:39 INFO - 'tests': ['tsvgm']}}, 04:13:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['damp', 'tps']}, 04:13:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['damp', 'tps']}, 04:13:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:39 INFO - 'other': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other_l64': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'svgr': {'tests': ['tsvgx', 04:13:39 INFO - 'tsvgr_opacity', 04:13:39 INFO - 'tart', 04:13:39 INFO - 'tscrollx', 04:13:39 INFO - 'cart']}, 04:13:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tsvgx', 04:13:39 INFO - 'tsvgr_opacity', 04:13:39 INFO - 'tart', 04:13:39 INFO - 'tscrollx', 04:13:39 INFO - 'cart']}, 04:13:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['tp5o']}, 04:13:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tp5o']}, 04:13:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--xperf_path', 04:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:39 INFO - 'tests': ['tp5n']}, 04:13:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s', 04:13:39 INFO - '--xperf_path', 04:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:39 INFO - 'tests': ['tp5n']}}, 04:13:39 INFO - 'talos.zip': {'path': '', 04:13:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running create-virtualenv step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: create_virtualenv 04:13:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:39 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 04:13:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:39 INFO - Using real prefix '/usr' 04:13:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:42 INFO - Installing pip.................done. 04:13:42 INFO - Return code: 0 04:13:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:42 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 04:13:42 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 04:13:42 INFO - Using env: {'DISPLAY': ':0', 04:13:42 INFO - 'HOME': '/home/cltbld', 04:13:42 INFO - 'LANG': 'en_US.UTF-8', 04:13:42 INFO - 'LANGUAGE': 'en_US:en', 04:13:42 INFO - 'LOGNAME': 'cltbld', 04:13:42 INFO - 'MAIL': '/var/mail/cltbld', 04:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:42 INFO - 'MOZ_NO_REMOTE': '1', 04:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:42 INFO - 'NO_EM_RESTART': '1', 04:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:42 INFO - 'PWD': '/builds/slave/test', 04:13:42 INFO - 'SHELL': '/bin/bash', 04:13:42 INFO - 'SHLVL': '1', 04:13:42 INFO - 'TERM': 'linux', 04:13:42 INFO - 'TMOUT': '86400', 04:13:42 INFO - 'USER': 'cltbld', 04:13:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:42 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 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 04:13:42 INFO - Cleaning up... 04:13:42 INFO - Return code: 0 04:13:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:42 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 04:13:42 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 04:13:42 INFO - Using env: {'DISPLAY': ':0', 04:13:42 INFO - 'HOME': '/home/cltbld', 04:13:42 INFO - 'LANG': 'en_US.UTF-8', 04:13:42 INFO - 'LANGUAGE': 'en_US:en', 04:13:42 INFO - 'LOGNAME': 'cltbld', 04:13:42 INFO - 'MAIL': '/var/mail/cltbld', 04:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:42 INFO - 'MOZ_NO_REMOTE': '1', 04:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:42 INFO - 'NO_EM_RESTART': '1', 04:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:42 INFO - 'PWD': '/builds/slave/test', 04:13:42 INFO - 'SHELL': '/bin/bash', 04:13:42 INFO - 'SHLVL': '1', 04:13:42 INFO - 'TERM': 'linux', 04:13:42 INFO - 'TMOUT': '86400', 04:13:42 INFO - 'USER': 'cltbld', 04:13:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:42 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 INFO - Downloading/unpacking psutil>=0.7.1 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:44 INFO - Installing collected packages: psutil 04:13:44 INFO - Running setup.py install for psutil 04:13:44 INFO - building 'psutil._psutil_linux' extension 04:13:44 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 04:13:44 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 04:13:44 INFO - building 'psutil._psutil_posix' extension 04:13:44 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 04:13:45 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 04:13:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:45 INFO - Successfully installed psutil 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:45 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 04:13:45 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 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:45 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 04:13:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:13:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:13:47 INFO - Installing collected packages: mozsystemmonitor 04:13:47 INFO - Running setup.py install for mozsystemmonitor 04:13:47 INFO - Successfully installed mozsystemmonitor 04:13:47 INFO - Cleaning up... 04:13:47 INFO - Return code: 0 04:13:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:47 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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:47 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 04:13:47 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 04:13:47 INFO - Using env: {'DISPLAY': ':0', 04:13:47 INFO - 'HOME': '/home/cltbld', 04:13:47 INFO - 'LANG': 'en_US.UTF-8', 04:13:47 INFO - 'LANGUAGE': 'en_US:en', 04:13:47 INFO - 'LOGNAME': 'cltbld', 04:13:47 INFO - 'MAIL': '/var/mail/cltbld', 04:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:47 INFO - 'MOZ_NO_REMOTE': '1', 04:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:47 INFO - 'NO_EM_RESTART': '1', 04:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:47 INFO - 'PWD': '/builds/slave/test', 04:13:47 INFO - 'SHELL': '/bin/bash', 04:13:47 INFO - 'SHLVL': '1', 04:13:47 INFO - 'TERM': 'linux', 04:13:47 INFO - 'TMOUT': '86400', 04:13:47 INFO - 'USER': 'cltbld', 04:13:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:47 INFO - '_': '/tools/buildbot/bin/python'} 04:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:50 INFO - Downloading docopt-0.6.1.tar.gz 04:13:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:50 INFO - Running setup.py install for blobuploader 04:13:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:50 INFO - Running setup.py install for requests 04:13:50 INFO - Running setup.py install for docopt 04:13:50 INFO - Successfully installed blobuploader requests docopt 04:13:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:50 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')]} 04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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')]} 04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:50 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 04:13:50 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 04:13:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 INFO - Running setup.py (path:/tmp/pip-c8CE9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:50 INFO - Running setup.py (path:/tmp/pip-znn0Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:51 INFO - Running setup.py (path:/tmp/pip-ek_8iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:51 INFO - Running setup.py (path:/tmp/pip-gulEFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:51 INFO - Running setup.py (path:/tmp/pip-nPmxBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:51 INFO - Running setup.py (path:/tmp/pip-mXlzTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:51 INFO - Running setup.py (path:/tmp/pip-4wMIBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:51 INFO - Running setup.py (path:/tmp/pip-Plpcpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:51 INFO - Running setup.py (path:/tmp/pip-L0DEQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:51 INFO - Running setup.py (path:/tmp/pip-7CIsfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:51 INFO - Running setup.py (path:/tmp/pip-F5E8Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:51 INFO - Running setup.py (path:/tmp/pip-TEG60K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 INFO - Running setup.py (path:/tmp/pip-zeYPBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 INFO - Running setup.py (path:/tmp/pip-gddXzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 INFO - Running setup.py (path:/tmp/pip-Dwa_Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:51 INFO - Running setup.py (path:/tmp/pip-y2E2dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:52 INFO - Running setup.py (path:/tmp/pip-mh4fSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:52 INFO - Running setup.py install for manifestparser 04:13:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozcrash 04:13:52 INFO - Running setup.py install for mozdebug 04:13:52 INFO - Running setup.py install for mozdevice 04:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozfile 04:13:52 INFO - Running setup.py install for mozhttpd 04:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozinfo 04:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozInstall 04:13:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozleak 04:13:53 INFO - Running setup.py install for mozlog 04:13:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Running setup.py install for moznetwork 04:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Running setup.py install for mozprocess 04:13:53 INFO - Running setup.py install for mozprofile 04:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Running setup.py install for mozrunner 04:13:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Running setup.py install for mozscreenshot 04:13:53 INFO - Running setup.py install for moztest 04:13:53 INFO - Running setup.py install for mozversion 04:13:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', '-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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:53 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 04:13:53 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 04:13:53 INFO - Using env: {'DISPLAY': ':0', 04:13:53 INFO - 'HOME': '/home/cltbld', 04:13:53 INFO - 'LANG': 'en_US.UTF-8', 04:13:53 INFO - 'LANGUAGE': 'en_US:en', 04:13:53 INFO - 'LOGNAME': 'cltbld', 04:13:53 INFO - 'MAIL': '/var/mail/cltbld', 04:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:53 INFO - 'MOZ_NO_REMOTE': '1', 04:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:53 INFO - 'NO_EM_RESTART': '1', 04:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:53 INFO - 'PWD': '/builds/slave/test', 04:13:53 INFO - 'SHELL': '/bin/bash', 04:13:53 INFO - 'SHLVL': '1', 04:13:53 INFO - 'TERM': 'linux', 04:13:53 INFO - 'TMOUT': '86400', 04:13:53 INFO - 'USER': 'cltbld', 04:13:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:53 INFO - '_': '/tools/buildbot/bin/python'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:54 INFO - Running setup.py (path:/tmp/pip-Z8VWcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:54 INFO - Running setup.py (path:/tmp/pip-jcZxSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:54 INFO - Running setup.py (path:/tmp/pip-tdWd8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:54 INFO - Running setup.py (path:/tmp/pip-bp_UKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:54 INFO - Running setup.py (path:/tmp/pip-M50gqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:54 INFO - Running setup.py (path:/tmp/pip-k6ivkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:54 INFO - Running setup.py (path:/tmp/pip-iisTTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:54 INFO - Running setup.py (path:/tmp/pip-pqk3eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:54 INFO - Running setup.py (path:/tmp/pip-ijOcJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:54 INFO - Running setup.py (path:/tmp/pip-Y3_LkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:54 INFO - Running setup.py (path:/tmp/pip-wlyJ4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:54 INFO - Running setup.py (path:/tmp/pip-Qwf6u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:54 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)) 04:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:55 INFO - Running setup.py (path:/tmp/pip-y6RyXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:55 INFO - Running setup.py (path:/tmp/pip-advmHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:55 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)) 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:55 INFO - Running setup.py (path:/tmp/pip-y4bGyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:55 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)) 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:55 INFO - Running setup.py (path:/tmp/pip-0EruOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:55 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)) 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:55 INFO - Running setup.py (path:/tmp/pip-MOcSSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:55 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)) 04:13:55 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)) 04:13:55 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)) 04:13:55 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)) 04:13:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - Downloading blessings-1.5.1.tar.gz 04:13:57 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 04:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:57 INFO - Installing collected packages: blessings 04:13:57 INFO - Running setup.py install for blessings 04:13:57 INFO - Successfully installed blessings 04:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:57 INFO - Reading from file tmpfile_stdout 04:13:57 INFO - Current package versions: 04:13:57 INFO - argparse == 1.2.1 04:13:57 INFO - blessings == 1.5.1 04:13:57 INFO - blobuploader == 1.2.4 04:13:57 INFO - docopt == 0.6.1 04:13:57 INFO - manifestparser == 1.1 04:13:57 INFO - mozInstall == 1.12 04:13:57 INFO - mozcrash == 0.16 04:13:57 INFO - mozdebug == 0.1 04:13:57 INFO - mozdevice == 0.48 04:13:57 INFO - mozfile == 1.2 04:13:57 INFO - mozhttpd == 0.7 04:13:57 INFO - mozinfo == 0.9 04:13:57 INFO - mozleak == 0.1 04:13:57 INFO - mozlog == 3.1 04:13:57 INFO - moznetwork == 0.27 04:13:57 INFO - mozprocess == 0.22 04:13:57 INFO - mozprofile == 0.28 04:13:57 INFO - mozrunner == 6.11 04:13:57 INFO - mozscreenshot == 0.1 04:13:57 INFO - mozsystemmonitor == 0.0 04:13:57 INFO - moztest == 0.7 04:13:57 INFO - mozversion == 1.4 04:13:57 INFO - psutil == 3.1.1 04:13:57 INFO - requests == 1.2.3 04:13:57 INFO - wsgiref == 0.1.2 04:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:57 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 04:13:57 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 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:57 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 2)) 04:13:57 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 3)) 04:13:57 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 4)) 04:13:57 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 5)) 04:13:57 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 6)) 04:13:57 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 7)) 04:13:57 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 8)) 04:13:57 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 9)) 04:13:57 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:57 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 4)) 04:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Downloading/unpacking jsonschema 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:13:59 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:59 INFO - warning: no files found matching '*.txt' 04:13:59 INFO - no previously-included directories found matching 'build' 04:13:59 INFO - no previously-included directories found matching 'dist' 04:13:59 INFO - no previously-included directories found matching '.git*' 04:13:59 INFO - Installing collected packages: jsonschema, functools32 04:13:59 INFO - Running setup.py install for functools32 04:14:00 INFO - warning: no files found matching '*.txt' 04:14:00 INFO - no previously-included directories found matching 'build' 04:14:00 INFO - no previously-included directories found matching 'dist' 04:14:00 INFO - no previously-included directories found matching '.git*' 04:14:00 INFO - Successfully installed jsonschema functools32 04:14:00 INFO - Cleaning up... 04:14:00 INFO - Return code: 0 04:14:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff4606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2984dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, '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': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', '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 04:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:00 INFO - Downloading/unpacking flake8 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:14:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:14:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:14:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:02 INFO - no previously-included directories found matching 'docs/_build' 04:14:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:02 INFO - Running setup.py install for pep8 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:02 INFO - no previously-included directories found matching 'docs/_build' 04:14:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Running post-action listener: _resource_record_post_action 04:14:02 INFO - Running post-action listener: _start_resource_monitoring 04:14:02 INFO - Starting resource monitoring. 04:14:02 INFO - ##### 04:14:02 INFO - ##### Running install step. 04:14:02 INFO - ##### 04:14:02 INFO - Running pre-action listener: _resource_record_pre_action 04:14:02 INFO - Running main action method: install 04:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:03 INFO - Reading from file tmpfile_stdout 04:14:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:03 INFO - Reading from file tmpfile_stdout 04:14:03 INFO - Output received: 04:14:03 INFO - Usage: mozinstall [options] installer 04:14:03 INFO - Options: 04:14:03 INFO - -h, --help show this help message and exit 04:14:03 INFO - -d DEST, --destination=DEST 04:14:03 INFO - Directory to install application into. [default: 04:14:03 INFO - "/builds/slave/test"] 04:14:03 INFO - --app=APP Application being installed. [default: firefox] 04:14:03 INFO - mkdir: /builds/slave/test/build/application 04:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:18 INFO - Reading from file tmpfile_stdout 04:14:18 INFO - Output received: 04:14:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:18 INFO - Running post-action listener: _resource_record_post_action 04:14:18 INFO - ##### 04:14:18 INFO - ##### Running run-tests step. 04:14:18 INFO - ##### 04:14:18 INFO - Running pre-action listener: _resource_record_pre_action 04:14:18 INFO - Running main action method: run_tests 04:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:18 INFO - Python 2.7.3 04:14:18 INFO - Return code: 0 04:14:18 INFO - grabbing minidump binary from tooltool 04:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a173d0>, '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 0x2982ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2983360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:14:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:14:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:19 INFO - Return code: 0 04:14:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:19 INFO - Return code: 0 04:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:14:19 INFO - Using env: {'DISPLAY': ':0', 04:14:19 INFO - 'HOME': '/home/cltbld', 04:14:19 INFO - 'LANG': 'en_US.UTF-8', 04:14:19 INFO - 'LANGUAGE': 'en_US:en', 04:14:19 INFO - 'LOGNAME': 'cltbld', 04:14:19 INFO - 'MAIL': '/var/mail/cltbld', 04:14:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:19 INFO - 'MOZ_NO_REMOTE': '1', 04:14:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:19 INFO - 'NO_EM_RESTART': '1', 04:14:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:19 INFO - 'PWD': '/builds/slave/test', 04:14:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:19 INFO - 'SHELL': '/bin/bash', 04:14:19 INFO - 'SHLVL': '1', 04:14:19 INFO - 'TERM': 'linux', 04:14:19 INFO - 'TMOUT': '86400', 04:14:19 INFO - 'USER': 'cltbld', 04:14:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995', 04:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:19 INFO - '_': '/tools/buildbot/bin/python'} 04:14:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:14:20 INFO - mozversion application_buildid: 20160119025837 04:14:20 INFO - mozversion application_changeset: 939a20ef46ea94c7ba92b1113382869d7163e06f 04:14:20 INFO - mozversion application_display_name: Nightly 04:14:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:20 INFO - mozversion application_name: Firefox 04:14:20 INFO - mozversion application_remotingname: firefox 04:14:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:20 INFO - mozversion application_vendor: Mozilla 04:14:20 INFO - mozversion application_version: 46.0a1 04:14:20 INFO - mozversion platform_buildid: 20160119025837 04:14:20 INFO - mozversion platform_changeset: 939a20ef46ea94c7ba92b1113382869d7163e06f 04:14:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:20 INFO - mozversion platform_version: 46.0a1 04:14:20 INFO - using testdate: 1453205660 04:14:20 INFO - actual date: 1453205660 04:14:20 INFO - starting webserver on 'localhost:54734' 04:14:20 INFO - SUITE-START | Running 3 tests 04:14:20 INFO - TEST-START | dromaeo_css 04:14:20 INFO - operating with platform_type : linux_ 04:14:20 INFO - Initialising browser for dromaeo_css test... 04:14:20 INFO - TEST-INFO | started process 24796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_lrcx/profile http://localhost:54734/getInfo.html) 04:14:23 INFO - PROCESS | 24796 | __metrics Screen width/height:1600/1200 04:14:23 INFO - PROCESS | 24796 | colorDepth:24 04:14:23 INFO - PROCESS | 24796 | Browser inner width/height: 1024/697 04:14:23 INFO - PROCESS | 24796 | __metrics 04:14:24 INFO - PROCESS | 24796 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:14:24 INFO - PROCESS | 24796 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:25 INFO - TEST-INFO | 24796: exit 0 04:14:25 INFO - Browser initialized. 04:14:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:25 INFO - TEST-INFO | started process 24888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_lrcx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:37 INFO - PROCESS | 24888 | RSS: Main: 150265856 04:14:37 INFO - PROCESS | 24888 | 04:15:28 INFO - PROCESS | 24888 | 1453205728043 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] 04:17:39 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54734/tests/dromaeo/cssquery-ext.html) 04:17:40 INFO - PROCESS | 24888 | RSS: Main: 251518976 04:17:40 INFO - PROCESS | 24888 | 04:20:42 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-ext.html (next: http://localhost:54734/tests/dromaeo/cssquery-jquery.html) 04:20:43 INFO - PROCESS | 24888 | RSS: Main: 237490176 04:20:43 INFO - PROCESS | 24888 | 04:23:45 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54734/tests/dromaeo/cssquery-mootools.html) 04:23:46 INFO - PROCESS | 24888 | RSS: Main: 237273088 04:23:46 INFO - PROCESS | 24888 | 04:26:48 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54734/tests/dromaeo/cssquery-prototype.html) 04:26:48 INFO - PROCESS | 24888 | RSS: Main: 209588224 04:26:48 INFO - PROCESS | 24888 | 04:29:51 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54734/tests/dromaeo/cssquery-yui.html) 04:29:51 INFO - PROCESS | 24888 | RSS: Main: 188567552 04:29:51 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | Cycle 1(1): loaded http://localhost:54734/tests/dromaeo/cssquery-yui.html (next: http://localhost:54734/tests/dromaeo/cssquery-dojo.html) 04:32:54 INFO - PROCESS | 24888 | RSS: Main: 258457600 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | __start_tp_report 04:32:54 INFO - PROCESS | 24888 | _x_x_mozilla_page_load 04:32:54 INFO - PROCESS | 24888 | _x_x_mozilla_page_load_details 04:32:54 INFO - PROCESS | 24888 | |i|pagename|runs| 04:32:54 INFO - PROCESS | 24888 | |0;dojo.html;2536.9619455708166;2569.768720815125;2581.819272650913;2599.012375297387;2599.0903183885634;4268.3384075468275;4317.071829556645;4321.157374312011;4347.60871521563;4355.259605867002;4362.716423432483;4370.257056300428;4389.561043895616;4407.140607581523;4455.487618923825;4002.8198731057028;4040.1313717550647;4087.0599762054744;4161.667066634677;4170.645495132917;3976.3637817949134;4102.3436250199975;4150.169966006811;4155.148194620096;4162.396452514384;4003.499562554681;4014.8594799182033;4041.0503531670033;4071.938920916159;4094.549599544048;4057.046594050396;4062.228176646457;4067.3085575452246;4089.693273004507;4094.1811637672286;4046.898827529306;4046.919061618751;4049.1496785675045;4050.432939388488;4082.142750022499;4179.393987871742;4292.613664770154;4297.527272000078;4311.504177019651;4401.735895846227;4701.036287561042;4705.952940470585;4712.552307530779;4718.669693121483;4752.59602933751;4723.6929599575915;4730.337752714623;4730.881727956794;4731.36126622905;4767.570918617306;4305.052888364555;4351.347297905276;4370.7159034662645;4375.562443755663;4400.361947517592;4822.807087716452;4830.106430310404;4837.250226214942;4843.055604157155;4843.297721830315;4661.883452913704;4663.533646635309;4666.510016448292;4669.252919532859;4670.626349892001;4613.976930115328;4677.415323084614;4698.224792909132;4698.553637404441;4735.195016847076;4592.839250626212;4652.441706995114;4671.019085991979;4672.976635116871;4713.6464765142755;4615.169269531517;4652.813887444532;4654.767261636905;4658.301254811738;4687.507811679793;3931.1941052084253;3975.6819454443576;3986.920261594752;4010.7393019454225;4062.025113972625;3528.153243221608;3531.5938667053106;3539.7876127431923;3548.6628770266784;3569.5538057742783;4062.979685101556;4069.613386728256;4074.7555146691293;4095.85664501747;4107.158032603309;4621.95378046222;4623.12160689468;4703.952960470351;4709.929351059737;4710.9764451177525;4106.897327566835;4110.8561200358445;4112.691548133902;4123.443335149776;4150.626443620089;4293.8711838644895;4314.741115533078;4316.330968699856;4356.302991521341;4369.994901172748;4391.187630288407;4447.199504089295;4463.174312752151;4480.991776850183;4541.205289074399;4678.719276843401;4697.694649847749;4706.8117275308605;4722.881927951691;4730.385049943486;4456.086502267092;4458.398116254264;4470.061287129739;4473.955260447354;4509.954900450954;4509.706869053501;4592.104539614743;4595.241785105421;4600.355950166912;4610.40064791575;4660.6970546914345;4674.7896344663895;4676.181668208118;4687.718736875799;4727.716337019652;4493.887652808706;4503.459584849839;4506.504284528633;4507.864764057083;4552.88617784558;4390.473143222834;4501.90996180068;4503.099380123923;4507.166174257773;4514.187446259705;4384.802683879169;4410.82356705741;4413.382126502228;4424.093060922439;4452.042810795565;4552.635789136795;4566.086782643551;4577.473590536998;4582.977085114553;4620.815167393266;4349.543297953795;4428.535003824552;4433.3349997499345;4502.369668246513;4508.481524624579 04:32:54 INFO - PROCESS | 24888 | |1;ext.html;499.4955095353692;506.1041955738343;518.3313525552039;532.6644214145088;544.7466927878537;25125;25465.74534254657;25526.234212973617;25529;32746.345073098582;35662.2867542649;36072.09819754508;36138.63861361385;36204.45693314602;36205.275894482096;7688.538687678743;7876.921230787705;7880.724174653888;7881.448298619099;7884.566348850811;7653.617319134049;7759.146493885668;7776.183500732426;7780.805479862992;7793.532388056707;7740.4968677036095;7828.765137045898;7832.56920869352;7838.059432868035;8052.355811535063;7870.606469676522;7922.405819563527;7922.762317130438;7992.960035199787;7995.360371170293;7679.961600192019;7768.300852923264;7800.258975397328;7816.101148367897;7820.726274580363;36859.07852303714;37336;37357;37455.625443745485;37482.06294842623;2910.607068045808;2982.522796352573;3399.286149908522;3467.7225821934185;3582.283543291326;28572.57141142864;28601.85699071512;28852;29077.854610726812;29450.263743406373;3316.800991940467;3364.226227967581;3384.6953774160197;3395.0632702712223;3448.0345503259127;213116;214730;214787;214828;215667;44794;46566;53331;53636;53677;57212.42787572071;58404.707976459846;58711.70644146837;58761.41238587559;58776.70611646914;14183.21992290434;14226.573202803933;14259.42962281497;14303.928480357532;14373.568792936228;10036.548355323883;10449.791004179873;10966.835497467544;11371.545138194546;11479.885201147881;18522.81477185238;18952.52618684544;18969.525761856064;18981.33565325207;19014.904925475283;7012.298770122947;7210.351068403764;7243.601601911945;7311.393821892174;7397.81505462357;845.218173189797;913.3058875254854;932.3054324528134;953.3088510829593;1039.9012093851072;26886.5967010495;27142.728572714415;27288.45423091527;27416.725832741817;27449.725502744717;845.8942632170979;892.5180402582663;990.1484723138095;1018.6078359831519;1044.8328267477168;13970.860291396955;14020.789688154686;14238.721804511228;14318.212498312485;14349.928250358891;249959;255597;255669;256078;256218;45251;45251.77374113108;45722.542774572496;45737.542624573995;45821.31268030982;1231.0582404460595;1241.5840693367822;1247.1519366830642;1247.8440194975628;1256.4220458589152;25007.374815629755;25992.35019124537;26315;26455.33861653474;26648.8667556661;35343.29313413666;36236.81881590575;40450.59549404586;40950.59049409468;41732.58267417287;159030;159201.2039939793;159870;160216;160546;24739.25782226536;24963.75036249687;25027.499450010535;25031.12391066304;25033.624495632943;30321;33341.499877501374;36635.81682091679;37295;37740.2451950965;27758.861205693844;27778.166655000383;29381.41237175287;29492.55761163627;29635.407291854473;31339.843300783352;31382.215444613154;31762;32226.83886580552;32314;32058.19854503656;32321.51517727189;32379.51430728588;32843.50734738933;33221.83389083039;25757;29615.703842961295;29654.406911862072;29770.404591908475;29845.70154298516;23346.533069338857;24757.752422475543;25553.744462555136;25563.48873022492;25960 04:32:54 INFO - PROCESS | 24888 | |2;jquery.html;333.0923234186841;339.24010217113675;341.598621619597;343.5413722680222;344.72594287541403;11371.431428428567;11771.823422648667;13845;14177.653122953316;15153.166575838324;13896.722065558683;14363.425462981468;14580.343884525195;15289.847101528982;15419.306131224093;4630.606398456119;4697.9765101174535;4840.903181936359;4853.053654537367;4881.877953051185;3558.323918455485;3737.383331750258;5276.234945932857;5540.335159780832;5544.889102217953;5347.491988261109;5509.311336082989;5520.227168196456;5524.66851988882;5614.494695477406;5479.2602998595075;5513.61404701671;5518.392976772552;5519.475649813281;5523.7238138092935;4750.12122757291;4803.879903002418;4872.951270487285;4875.804967801319;4877.926831097537;17357.913210433868;17562.560935976577;17705.29178832845;17759;17819.376321828673;1895.5450691833998;1915.1094740945389;1941.834944029759;1997.8801271923585;2080.3966849613744;11699;11782.941085294604;11808.822867656907;12037.398130093461;12404.007679385717;1647.6292834112348;1663.6173680053535;1738.452387497934;1759.375421725282;1812.6102887879038;47413;48628.32211021215;48661.75669121667;49027.26459103116;49971.50028499705;8835.249003834617;8952.015278319379;9096.636134554676;9098.090190980849;9168.44989300644;11452.427378631035;11458.427078646035;11494;11495.827562586568;11521.942390287995;6689.297623749533;6966.407855332252;7032.5077244592385;7109.360157585842;7233.31283528064;6789.388954993976;6817.147856517935;6821.420179284816;6838.418734407631;6896.517243792886;3696.168362118502;3962.603739626072;3986.621270979252;3995.5016868674247;3997.7801220932547;1614.4995051534063;1615.6041769766248;1679.6304812941135;1685.4438035448272;1693.280355848784;375.9830807613664;380.0650400015992;396.54991584551743;825.9917400826035;839.3327304792705;8812.91187088121;13310.933445332712;14328.928355358157;15836.366545338287;16342.346306147621;817.5229055960331;856.0968178571667;875.899271583776;897.8967418746797;941.9945322714868;8203.179682031749;8496.150384961578;8866.246369058574;8896.911030889609;9014.323925705598;434588;435583;446555;449207;449414;54403.45596543984;62305.68847155826;64231;65307;65682;1000.6097621927308;1028.0798685176726;1036.362636978253;1039.6205385034407;1074.0119090436817;13819.170849749047;13918.58244252674;14056.297185140498;14323.49603291681;14373.28133593337;20146.39560813178;28638.856805715837;29600.555991659712;29775.255618609706;31092.844535777178;39063.60936390713;39418.802905985285;39636.60363396329;39943.2011359777;40059.799701001306;6146.200993870768;6210.285817131088;6370.140031095742;6377.7767778127545;6742.86514269702;7631.351335136354;9021.639134434548;9458.101480359355;9694.127528522467;10086.29395942277;8436.831263374575;8680.565971701515;8691.174338437839;8701.17338852808;8845.071267517076;7992.84014319722;8537.359698022798;8626.741197764077;8627.580280958497;8860.778480538038;8650.870236946324;8755.518446485505;8894.42186257891;8897.510636915033;8951.373403861668;6468.029795530708;6527.902081468686;6561.278259391368;6608.074869518176;6750.898736518858;7731.729389471567;9119.772005699911;9241.168294853227;9347.485888276211;9366.718998430058 04:32:54 INFO - PROCESS | 24888 | |3;mootools.html;1215.185825496917;1370.9451621935123;1380.9240491772955;1483.5920121966458;1695.6015336395938;5803.419658034194;6432.195975503062;6624.86750264995;6643.435307998826;6649.335066493349;6575.9342406575915;6675.799726008216;6699.062131301622;6705.966470167642;6712.060311556374;1783.3223375117502;1816.8819026763217;2021.9393418197478;2063.1128614695676;2097.1087287902656;2026.2199053364413;2036.1244664794206;2036.541778099923;2037.5924815036979;2037.7962203779578;2020.3534868841975;2023.5750492396614;2075.792420757927;2079.5840831833616;2080.1991233375184;2014.2748610500207;2021.5148364392514;2030.0255877179036;2030.2995466564012;2080.906359213839;2012.1448384436555;2032.5121970726918;2036.3280117561317;2037.022229329915;2038.9082491287927;6832.829179270509;6873.381395674413;6906.482013848981;6910.792676219721;6910.896336554955;3932.7836968966694;4077.3068578341754;4099.405586189986;4101.91796164075;4104.56902025289;2540.3522101863905;2633.5128001319817;2637.7626013658864;2639.4193277478926;2643.458091091341;849.142366210126;855.7860534866284;856.9700060497853;869.447900583128;897.3001059173789;9018.233450156744;9070.092990700943;9078.409903356194;9078.77303067422;9081.364304498687;3612.4942508048894;3708.2027364116843;3744.9625503744614;3773.660370566662;3777.1501412182038;7878.842423151505;7881.133075361706;7890.9605451972375;7892.131865494791;7892.84214315722;4081.2041651878194;4100.815463304159;4101.815418306183;4102.097538541516;4108.91782164361;3754.5869954305003;3759.9060023499082;3760.4923335349376;3762.1347090169415;3763.1156678180605;2906.593076969226;2981.567672687448;3162.3201011782576;3173.1115287719476;3230.9030729078167;1052.4632437456953;1055.8574592430077;1066.195022757813;1071.6463567022863;1083.1767856429171;1152.1589239854952;1153.0314535789976;1175.9235649682744;1177.3171560494893;1190.9821352679717;6276.592021518587;6302.1492098566105;6336.524760642878;6341.397567231105;6376.904346434807;945.177695405002;962.1965658675085;964.9421034737938;972.8054389122204;1060.6393826099163;5038.949610503848;5074.771635276422;5083.822066227738;5103.081445339801;5107.182850743863;7606.125295590967;7758.728444504528;7776.8055798604355;7814.882776758353;7821.413393995473;7797.571133587707;7896.921030789734;7902.94523423914;7909.485883417559;7909.960450197712;6328.557001009885;6371.39471750183;6426;6441.066045423388;6468.708908099241;6270.15352927349;6374.617522948638;6375.585586936834;6379.96810015947;6486.54594178403;7212.531185472927;7497.512661676974;7501.662425190989;7502.737404190827;7504.962475187589;7381.594012329373;7658.73194438192;7697.461177717506;7768.805779855549;7770.261825126604;6052.455279024909;6168.568200225941;6182.412670796267;6185.690715464299;6187.783427580013;6428;6517.087607734826;6539.967300163468;6543.672816359068;6569.868602628017;6226.968865155645;6293.181886354744;6381.138546296191;6407.455366293917;6408.61548307103;6179.969100154471;6290.930541807995;6348.269948955744;6353.332900045429;6394.360563943755;6153.969230154;6292.27638821523;6303.086052522451;6306.527010474141;6310.148130002391;5699.800506982236;5740.655560666373;5747.051736463437;5747.339056008613;5758.740856661544;5920.171176035445;5981.282246130492;6024.819255422344;6045.244344456943;6049.727762250621 04:32:54 INFO - PROCESS | 24888 | |4;prototype.html;292.9414117176565;303.1602461182525;304.7501049139705;307.5555821837446;309.85746556583956;5221.269022336871;5292.073887069767;5304.098303288441;5317.627766056377;5331.333583302087;5243.056249875021;5261.552768014713;5266.683998960065;5267.130923397644;5281.049411106;3890.280298144838;4107.363358679409;4108.424820525129;4135.772532510726;4150.045489537408;3972.066564357374;4012.638862502374;4111.794410279489;4145.875623731293;4153.418521407006;4063.451434056394;4096.631303182713;4097.67218622511;4101.712880098395;4110.835566577333;3859.459675645412;3962.207558488285;3973.4834471518516;4090.897727556805;4110.157417729373;3563.251717139404;3587.6950459211;3607.494950706903;3617.439296908957;3633.854645814164;5049.823256186052;5070.112730272188;5074.543291103819;5082.1360368737405;5082.669626474304;4713.104510143096;4714.339992401066;4716.693414928019;4719.764011799396;4721.457032441244;5438.646487978269;5556.222128901957;5560.916586251209;5564.998300305943;5589.105743081088;3859.536855577349;3897.9220415591813;3903.394973779069;3903.9609603904164;3906.8437262509465;5779.479846813807;5836.824895253107;5839.562032847553;5840.269966254218;5845.85385365365;4018.4173294872667;4020.557738648746;4021.698372622065;4022.8735953932946;4024.738392004569;3981.661558767479;4066.4916885389325;4066.8169932353117;4078.9184216316103;4080.0615858352744;4670.1126785910565;4673.953260467351;4676.976615116902;4677.041206552649;4679.087577922272;5528.474794894479;5532.5573954083575;5536.695481748542;5537.390887002426;5538.224648549206;1421.1189062780936;1445.992770036164;1454.2801313349748;1455.054214760393;1456.3519233941006;987.2299606306948;989.1314592417303;997.4264797741328;1012.1497941728983;1017.0338178730088;4877.365942427462;4894.241392584155;4895.828645997373;4898.559129678346;4899.6570240083565;5757.337906140764;5766.596338256366;5766.855828604234;5777.740001699934;5780.508656764138;4881.9511804881495;4892.461829198785;4893.486183950634;4893.608511319086;4896.755162241873;3027.666956634768;3074.738647215012;3100.1784527100335;3100.90697279082;3106.829124398135;5553.527950124204;5558.249636299129;5558.416366281563;5558.638688485235;5561.193626924073;5977.701114944235;5981.043033114681;5981.983062879321;5982.282126144803;5985.132155837379;5497.752601132958;5530.976769297693;5536.446355364431;5536.972315138399;5542.168674698827;5627.240322556566;5792.247007889116;5803.274590676166;5807.012807822764;5813.912791308049;5671.574631902541;5672.177534257427;5675.120356344773;5677.432256774455;5679.74441150141;5505.697186654773;5520.696361699985;5521.917171242515;5524.558035357242;5525.198846167203;3908.2769687607883;3944.165962827299;3983.64147226751;4006.3790112532606;4008.4388185654616;5797.101449275369;5855.063189889597;5860.38465961068;5868.618539794899;5871.882562348644;5543.667379957215;5544.417836127149;5549.084401073777;5550.195221692913;5558.082916318924;5528.336599608073;5540.556755459635;5542.057850165562;5545.611807173621;5554.055810512142;5231.241469986754;5400.62195646301;5404.081306177881;5404.135338345845;5404.32445944257;5389.27244821944;5533;5624.100143976944;5639.746211420414;5643.3792282848035;5306.708131052829;5389.514943654933;5400.432954539717;5410.107332290128;5434.429384914527 04:32:54 INFO - PROCESS | 24888 | |5;yui.html;721.1058287723222;739.6819367671901;747.5178509861144;754.4492520460064;761.311013532753;10746.194035447334;10760.623378181765;10769.407682577455;10835.458227088653;10895.67312980611;10287.742806429844;10367.533460994255;10367.688969330913;10368.326058806173;10368.637097701563;594.1889321076732;609.2871340531567;610.048324613602;747.0736287004103;760.9961950190269;755.493819141174;759.0208630866176;762.5653377574785;768.2125821033429;768.7924260449676;623.526120148688;810.2990912860392;810.6392655268407;812.3988248695981;813.2558708781457;628.7296462521114;629.238621268266;629.886620408324;630.0926665601542;780.1457404142454;594.7531774313654;595.2083728640897;596.2249076200922;597.9043353063532;598.335847209597;10423.739406514822;10461.320014199053;10521.053105220566;10526.842097368546;10588.894111058868;10403.479826008745;10749.086327662159;10965.83551246732;11127.888721112766;11155;9263.924571599597;9279.489628070454;9335.206507446876;9539.570719317579;9617.56720947559;3220.71013608774;3257.3322468894057;3288.44096503595;3299.109240505074;3307.5038744188323;39330.213395732215;39663.60336396657;39891.60108398908;39944.60055399438;40065;9343.299252556086;9399.859002114974;9524.809503809885;9542.475163866055;9555.952220238854;16208.351665933467;16229.107399092927;16244.350225991064;16278.43025494102;16290.266937987819;6522.21733391996;6532;6535.477161827042;6577.276499585042;6758.560693554903;3639.563252409675;3655.961109340147;3741.420079887622;3747.081964918558;3766.3973764198145;2468.679071720665;2487.5398051360557;2506.223070848043;2508.8620125893253;2513.3465299022387;451.58228638509905;453.0599007060363;457.66361724132736;457.81000884632505;458.8875725447287;448.46856475076487;455.794892298467;498.03629975996563;509.37487612478606;518.2870612625235;7210.495265331481;7276.96361518189;7342.265773422615;7499.737509187262;7563.508371955805;513.8150265904271;531.3570579598729;541.6479288462531;545.1767830575859;556.7800718716085;3153.526970954375;3213.1324542373427;3302.4055669979152;3336.816475093893;3346.564946556981;47020;47569;49872.251916221285;50222.24666630004;50232;41081.58918410837;41162.176756465306;41202.1759564807;41399.7930010348;41562;37347;37662;41557.792211039356;42413;42464.78767606142;7843.803904902423;7947.086085100287;7969.043714754266;8079.353651707732;8126.674933002851;30106.698933011266;30133.397332053675;30294.242643934078;30786.538201927437;30896;35073;35098.298034038664;35137.47293790544;38229;38348.42477362786;9771;9863.358881672668;9940.304178707422;9980.31770015298;10038.849417258602;10765.407902565434;10887.564497420331;11054.668359949215;11070;11079.224454288445;9334.813303734023;9545.952270238604;9590.808183836423;9738.220942324455;9841.60633574649;9882.11061004513;10369.429681367597;10508.894911050791;10514.842277365999;10678.985496378142;7870.763877083697;10190.745231369276;10327.586896524355;10417.270791044553;10590.364578125336;7984.6406911687955;8207.71273005442;8795.91204087951;8837.513936733541;8889.155530224618;8278.917210827814;8378.49729016261;8537.701180458655;8629.654813807378;8771.692990745549 04:32:54 INFO - PROCESS | 24888 | __end_tp_report 04:32:54 INFO - PROCESS | 24888 | __start_cc_report 04:32:54 INFO - PROCESS | 24888 | _x_x_mozilla_cycle_collect,841 04:32:54 INFO - PROCESS | 24888 | __end_cc_report 04:32:54 INFO - PROCESS | 24888 | __startTimestamp1453206774784__endTimestamp 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | ------- Summary: start ------- 04:32:54 INFO - PROCESS | 24888 | Number of tests: 6 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#0] dojo.html Cycles:165 Average:4344.84 Median:4433.33 stddev:425.20 (9.6%) stddev-sans-first:402.16 04:32:54 INFO - PROCESS | 24888 | Values: 2537.0 2569.8 2581.8 2599.0 2599.1 4268.3 4317.1 4321.2 4347.6 4355.3 4362.7 4370.3 4389.6 4407.1 4455.5 4002.8 4040.1 4087.1 4161.7 4170.6 3976.4 4102.3 4150.2 4155.1 4162.4 4003.5 4014.9 4041.1 4071.9 4094.5 4057.0 4062.2 4067.3 4089.7 4094.2 4046.9 4046.9 4049.1 4050.4 4082.1 4179.4 4292.6 4297.5 4311.5 4401.7 4701.0 4706.0 4712.6 4718.7 4752.6 4723.7 4730.3 4730.9 4731.4 4767.6 4305.1 4351.3 4370.7 4375.6 4400.4 4822.8 4830.1 4837.3 4843.1 4843.3 4661.9 4663.5 4666.5 4669.3 4670.6 4614.0 4677.4 4698.2 4698.6 4735.2 4592.8 4652.4 4671.0 4673.0 4713.6 4615.2 4652.8 4654.8 4658.3 4687.5 3931.2 3975.7 3986.9 4010.7 4062.0 3528.2 3531.6 3539.8 3548.7 3569.6 4063.0 4069.6 4074.8 4095.9 4107.2 4622.0 4623.1 4704.0 4709.9 4711.0 4106.9 4110.9 4112.7 4123.4 4150.6 4293.9 4314.7 4316.3 4356.3 4370.0 4391.2 4447.2 4463.2 4481.0 4541.2 4678.7 4697.7 4706.8 4722.9 4730.4 4456.1 4458.4 4470.1 4474.0 4510.0 4509.7 4592.1 4595.2 4600.4 4610.4 4660.7 4674.8 4676.2 4687.7 4727.7 4493.9 4503.5 4506.5 4507.9 4552.9 4390.5 4501.9 4503.1 4507.2 4514.2 4384.8 4410.8 4413.4 4424.1 4452.0 4552.6 4566.1 4577.5 4583.0 4620.8 4349.5 4428.5 4433.3 4502.4 4508.5 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#1] ext.html Cycles:180 Average:36859.05 Median:32317.76 stddev:55507.28 (171.8%) stddev-sans-first:55595.85 04:32:54 INFO - PROCESS | 24888 | Values: 499.5 506.1 518.3 532.7 544.7 25125.0 25465.7 25526.2 25529.0 32746.3 35662.3 36072.1 36138.6 36204.5 36205.3 7688.5 7876.9 7880.7 7881.4 7884.6 7653.6 7759.1 7776.2 7780.8 7793.5 7740.5 7828.8 7832.6 7838.1 8052.4 7870.6 7922.4 7922.8 7993.0 7995.4 7680.0 7768.3 7800.3 7816.1 7820.7 36859.1 37336.0 37357.0 37455.6 37482.1 2910.6 2982.5 3399.3 3467.7 3582.3 28572.6 28601.9 28852.0 29077.9 29450.3 3316.8 3364.2 3384.7 3395.1 3448.0 213116.0 214730.0 214787.0 214828.0 215667.0 44794.0 46566.0 53331.0 53636.0 53677.0 57212.4 58404.7 58711.7 58761.4 58776.7 14183.2 14226.6 14259.4 14303.9 14373.6 10036.5 10449.8 10966.8 11371.5 11479.9 18522.8 18952.5 18969.5 18981.3 19014.9 7012.3 7210.4 7243.6 7311.4 7397.8 845.2 913.3 932.3 953.3 1039.9 26886.6 27142.7 27288.5 27416.7 27449.7 845.9 892.5 990.1 1018.6 1044.8 13970.9 14020.8 14238.7 14318.2 14349.9 249959.0 255597.0 255669.0 256078.0 256218.0 45251.0 45251.8 45722.5 45737.5 45821.3 1231.1 1241.6 1247.2 1247.8 1256.4 25007.4 25992.4 26315.0 26455.3 26648.9 35343.3 36236.8 40450.6 40950.6 41732.6 159030.0 159201.2 159870.0 160216.0 160546.0 24739.3 24963.8 25027.5 25031.1 25033.6 30321.0 33341.5 36635.8 37295.0 37740.2 27758.9 27778.2 29381.4 29492.6 29635.4 31339.8 31382.2 31762.0 32226.8 32314.0 32058.2 32321.5 32379.5 32843.5 33221.8 25757.0 29615.7 29654.4 29770.4 29845.7 23346.5 24757.8 25553.7 25563.5 25960.0 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#2] jquery.html Cycles:180 Average:23463.43 Median:4846.98 stddev:72359.11 (1492.9%) stddev-sans-first:72541.25 04:32:54 INFO - PROCESS | 24888 | Values: 333.1 339.2 341.6 343.5 344.7 11371.4 11771.8 13845.0 14177.7 15153.2 13896.7 14363.4 14580.3 15289.8 15419.3 4630.6 4698.0 4840.9 4853.1 4881.9 3558.3 3737.4 5276.2 5540.3 5544.9 5347.5 5509.3 5520.2 5524.7 5614.5 5479.3 5513.6 5518.4 5519.5 5523.7 4750.1 4803.9 4873.0 4875.8 4877.9 17357.9 17562.6 17705.3 17759.0 17819.4 1895.5 1915.1 1941.8 1997.9 2080.4 11699.0 11782.9 11808.8 12037.4 12404.0 1647.6 1663.6 1738.5 1759.4 1812.6 47413.0 48628.3 48661.8 49027.3 49971.5 8835.2 8952.0 9096.6 9098.1 9168.4 11452.4 11458.4 11494.0 11495.8 11521.9 6689.3 6966.4 7032.5 7109.4 7233.3 6789.4 6817.1 6821.4 6838.4 6896.5 3696.2 3962.6 3986.6 3995.5 3997.8 1614.5 1615.6 1679.6 1685.4 1693.3 376.0 380.1 396.5 826.0 839.3 8812.9 13310.9 14328.9 15836.4 16342.3 817.5 856.1 875.9 897.9 942.0 8203.2 8496.2 8866.2 8896.9 9014.3 434588.0 435583.0 446555.0 449207.0 449414.0 54403.5 62305.7 64231.0 65307.0 65682.0 1000.6 1028.1 1036.4 1039.6 1074.0 13819.2 13918.6 14056.3 14323.5 14373.3 20146.4 28638.9 29600.6 29775.3 31092.8 39063.6 39418.8 39636.6 39943.2 40059.8 6146.2 6210.3 6370.1 6377.8 6742.9 7631.4 9021.6 9458.1 9694.1 10086.3 8436.8 8680.6 8691.2 8701.2 8845.1 7992.8 8537.4 8626.7 8627.6 8860.8 8650.9 8755.5 8894.4 8897.5 8951.4 6468.0 6527.9 6561.3 6608.1 6750.9 7731.7 9119.8 9241.2 9347.5 9366.7 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#3] mootools.html Cycles:180 Average:4783.45 Median:6181.19 stddev:2430.01 (39.3%) stddev-sans-first:2422.02 04:32:54 INFO - PROCESS | 24888 | Values: 1215.2 1370.9 1380.9 1483.6 1695.6 5803.4 6432.2 6624.9 6643.4 6649.3 6575.9 6675.8 6699.1 6706.0 6712.1 1783.3 1816.9 2021.9 2063.1 2097.1 2026.2 2036.1 2036.5 2037.6 2037.8 2020.4 2023.6 2075.8 2079.6 2080.2 2014.3 2021.5 2030.0 2030.3 2080.9 2012.1 2032.5 2036.3 2037.0 2038.9 6832.8 6873.4 6906.5 6910.8 6910.9 3932.8 4077.3 4099.4 4101.9 4104.6 2540.4 2633.5 2637.8 2639.4 2643.5 849.1 855.8 857.0 869.4 897.3 9018.2 9070.1 9078.4 9078.8 9081.4 3612.5 3708.2 3745.0 3773.7 3777.2 7878.8 7881.1 7891.0 7892.1 7892.8 4081.2 4100.8 4101.8 4102.1 4108.9 3754.6 3759.9 3760.5 3762.1 3763.1 2906.6 2981.6 3162.3 3173.1 3230.9 1052.5 1055.9 1066.2 1071.6 1083.2 1152.2 1153.0 1175.9 1177.3 1191.0 6276.6 6302.1 6336.5 6341.4 6376.9 945.2 962.2 964.9 972.8 1060.6 5038.9 5074.8 5083.8 5103.1 5107.2 7606.1 7758.7 7776.8 7814.9 7821.4 7797.6 7896.9 7902.9 7909.5 7910.0 6328.6 6371.4 6426.0 6441.1 6468.7 6270.2 6374.6 6375.6 6380.0 6486.5 7212.5 7497.5 7501.7 7502.7 7505.0 7381.6 7658.7 7697.5 7768.8 7770.3 6052.5 6168.6 6182.4 6185.7 6187.8 6428.0 6517.1 6540.0 6543.7 6569.9 6227.0 6293.2 6381.1 6407.5 6408.6 6180.0 6290.9 6348.3 6353.3 6394.4 6154.0 6292.3 6303.1 6306.5 6310.1 5699.8 5740.7 5747.1 5747.3 5758.7 5920.2 5981.3 6024.8 6045.2 6049.7 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#4] prototype.html Cycles:180 Average:4622.35 Median:5264.12 stddev:1356.87 (25.8%) stddev-sans-first:1321.19 04:32:54 INFO - PROCESS | 24888 | Values: 292.9 303.2 304.8 307.6 309.9 5221.3 5292.1 5304.1 5317.6 5331.3 5243.1 5261.6 5266.7 5267.1 5281.0 3890.3 4107.4 4108.4 4135.8 4150.0 3972.1 4012.6 4111.8 4145.9 4153.4 4063.5 4096.6 4097.7 4101.7 4110.8 3859.5 3962.2 3973.5 4090.9 4110.2 3563.3 3587.7 3607.5 3617.4 3633.9 5049.8 5070.1 5074.5 5082.1 5082.7 4713.1 4714.3 4716.7 4719.8 4721.5 5438.6 5556.2 5560.9 5565.0 5589.1 3859.5 3897.9 3903.4 3904.0 3906.8 5779.5 5836.8 5839.6 5840.3 5845.9 4018.4 4020.6 4021.7 4022.9 4024.7 3981.7 4066.5 4066.8 4078.9 4080.1 4670.1 4674.0 4677.0 4677.0 4679.1 5528.5 5532.6 5536.7 5537.4 5538.2 1421.1 1446.0 1454.3 1455.1 1456.4 987.2 989.1 997.4 1012.1 1017.0 4877.4 4894.2 4895.8 4898.6 4899.7 5757.3 5766.6 5766.9 5777.7 5780.5 4882.0 4892.5 4893.5 4893.6 4896.8 3027.7 3074.7 3100.2 3100.9 3106.8 5553.5 5558.2 5558.4 5558.6 5561.2 5977.7 5981.0 5982.0 5982.3 5985.1 5497.8 5531.0 5536.4 5537.0 5542.2 5627.2 5792.2 5803.3 5807.0 5813.9 5671.6 5672.2 5675.1 5677.4 5679.7 5505.7 5520.7 5521.9 5524.6 5525.2 3908.3 3944.2 3983.6 4006.4 4008.4 5797.1 5855.1 5860.4 5868.6 5871.9 5543.7 5544.4 5549.1 5550.2 5558.1 5528.3 5540.6 5542.1 5545.6 5554.1 5231.2 5400.6 5404.1 5404.1 5404.3 5389.3 5533.0 5624.1 5639.7 5643.4 5306.7 5389.5 5400.4 5410.1 5434.4 04:32:54 INFO - PROCESS | 24888 | 04:32:54 INFO - PROCESS | 24888 | [#5] yui.html Cycles:180 Average:11751.26 Median:23739.44 stddev:13331.99 (56.2%) stddev-sans-first:13343.66 04:32:54 INFO - PROCESS | 24888 | Values: 721.1 739.7 747.5 754.4 761.3 10746.2 10760.6 10769.4 10835.5 10895.7 10287.7 10367.5 10367.7 10368.3 10368.6 594.2 609.3 610.0 747.1 761.0 755.5 759.0 762.6 768.2 768.8 623.5 810.3 810.6 812.4 813.3 628.7 629.2 629.9 630.1 780.1 594.8 595.2 596.2 597.9 598.3 10423.7 10461.3 10521.1 10526.8 10588.9 10403.5 10749.1 10965.8 11127.9 11155.0 9263.9 9279.5 9335.2 9539.6 9617.6 3220.7 3257.3 3288.4 3299.1 3307.5 39330.2 39663.6 39891.6 39944.6 40065.0 9343.3 9399.9 9524.8 9542.5 9556.0 16208.4 16229.1 16244.4 16278.4 16290.3 6522.2 6532.0 6535.5 6577.3 6758.6 3639.6 3656.0 3741.4 3747.1 3766.4 2468.7 2487.5 2506.2 2508.9 2513.3 451.6 453.1 457.7 457.8 458.9 448.5 455.8 498.0 509.4 518.3 7210.5 7277.0 7342.3 7499.7 7563.5 513.8 531.4 541.6 545.2 556.8 3153.5 3213.1 3302.4 3336.8 3346.6 47020.0 47569.0 49872.3 50222.2 50232.0 41081.6 41162.2 41202.2 41399.8 41562.0 37347.0 37662.0 41557.8 42413.0 42464.8 7843.8 7947.1 7969.0 8079.4 8126.7 30106.7 30133.4 30294.2 30786.5 30896.0 35073.0 35098.3 35137.5 38229.0 38348.4 9771.0 9863.4 9940.3 9980.3 10038.8 10765.4 10887.6 11054.7 11070.0 11079.2 9334.8 9546.0 9590.8 9738.2 9841.6 9882.1 10369.4 10508.9 10514.8 10679.0 7870.8 10190.7 10327.6 10417.3 10590.4 7984.6 8207.7 8795.9 8837.5 8889.2 8278.9 8378.5 8537.7 8629.7 8771.7 04:32:54 INFO - PROCESS | 24888 | -------- Summary: end -------- 04:32:54 INFO - PROCESS | 24888 | 04:32:55 INFO - TEST-INFO | 24888: exit 0 04:32:55 INFO - TEST-OK | dromaeo_css | took 1115334ms 04:32:55 INFO - TEST-START | kraken 04:32:55 INFO - operating with platform_type : linux_ 04:32:55 INFO - Initialising browser for kraken test... 04:32:55 INFO - TEST-INFO | started process 25087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvu8j8/profile http://localhost:54734/getInfo.html) 04:32:59 INFO - PROCESS | 25087 | __metrics Screen width/height:1600/1200 04:32:59 INFO - PROCESS | 25087 | colorDepth:24 04:32:59 INFO - PROCESS | 25087 | Browser inner width/height: 1024/697 04:32:59 INFO - PROCESS | 25087 | __metrics 04:32:59 INFO - PROCESS | 25087 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:32:59 INFO - PROCESS | 25087 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:00 INFO - TEST-INFO | 25087: exit 0 04:33:00 INFO - Browser initialized. 04:33:00 INFO - Running cycle 1/1 for kraken test... 04:33:00 INFO - TEST-INFO | started process 25166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvu8j8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:12 INFO - PROCESS | 25166 | RSS: Main: 150241280 04:33:12 INFO - PROCESS | 25166 | 04:33:15 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54734/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:15 INFO - PROCESS | 25166 | RSS: Main: 187969536 04:33:15 INFO - PROCESS | 25166 | 04:33:18 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54734/tests/kraken/driver.html?testName=audio-dft) 04:33:19 INFO - PROCESS | 25166 | RSS: Main: 177389568 04:33:19 INFO - PROCESS | 25166 | 04:33:22 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54734/tests/kraken/driver.html?testName=audio-fft) 04:33:22 INFO - PROCESS | 25166 | RSS: Main: 161214464 04:33:22 INFO - PROCESS | 25166 | 04:33:24 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54734/tests/kraken/driver.html?testName=audio-oscillator) 04:33:25 INFO - PROCESS | 25166 | RSS: Main: 163123200 04:33:25 INFO - PROCESS | 25166 | 04:33:27 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:28 INFO - PROCESS | 25166 | RSS: Main: 166227968 04:33:28 INFO - PROCESS | 25166 | 04:33:31 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54734/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:31 INFO - PROCESS | 25166 | RSS: Main: 165494784 04:33:31 INFO - PROCESS | 25166 | 04:33:35 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54734/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:35 INFO - PROCESS | 25166 | RSS: Main: 166281216 04:33:35 INFO - PROCESS | 25166 | 04:33:38 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54734/tests/kraken/driver.html?testName=json-parse-financial) 04:33:39 INFO - PROCESS | 25166 | RSS: Main: 168996864 04:33:39 INFO - PROCESS | 25166 | 04:33:40 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:41 INFO - PROCESS | 25166 | RSS: Main: 181575680 04:33:41 INFO - PROCESS | 25166 | 04:33:43 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:43 INFO - PROCESS | 25166 | RSS: Main: 179232768 04:33:43 INFO - PROCESS | 25166 | 04:33:46 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:46 INFO - PROCESS | 25166 | RSS: Main: 189067264 04:33:46 INFO - PROCESS | 25166 | 04:33:49 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:49 INFO - PROCESS | 25166 | RSS: Main: 194347008 04:33:49 INFO - PROCESS | 25166 | 04:33:52 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:52 INFO - PROCESS | 25166 | RSS: Main: 193417216 04:33:52 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | Cycle 1(1): loaded http://localhost:54734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54734/tests/kraken/driver.html?testName=ai-astar) 04:33:54 INFO - PROCESS | 25166 | RSS: Main: 252661760 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | __start_tp_report 04:33:54 INFO - PROCESS | 25166 | _x_x_mozilla_page_load 04:33:54 INFO - PROCESS | 25166 | _x_x_mozilla_page_load_details 04:33:54 INFO - PROCESS | 25166 | |i|pagename|runs| 04:33:54 INFO - PROCESS | 25166 | |0;ai-astar;115;115;108;113;113;114;113;114;106;113 04:33:54 INFO - PROCESS | 25166 | |1;audio-beat-detection;161;153;153;179;132;157;157;130;179;140 04:33:54 INFO - PROCESS | 25166 | |2;audio-dft;164;160;162;161;162;160;163;164;161;163 04:33:54 INFO - PROCESS | 25166 | |3;audio-fft;72;73;80;96;73;71;72;113;91;71 04:33:54 INFO - PROCESS | 25166 | |4;audio-oscillator;96;97;139;97;97;97;134;96;98;137 04:33:54 INFO - PROCESS | 25166 | |5;imaging-gaussian-blur;109;108;110;109;109;109;110;110;110;109 04:33:54 INFO - PROCESS | 25166 | |6;imaging-darkroom;146;147;147;146;146;148;146;147;148;147 04:33:54 INFO - PROCESS | 25166 | |7;imaging-desaturate;96;96;95;95;95;96;96;96;96;95 04:33:54 INFO - PROCESS | 25166 | |8;json-parse-financial;67;68;67;67;68;68;68;69;77;77 04:33:54 INFO - PROCESS | 25166 | |9;json-stringify-tinderbox;68;68;66;67;68;68;68;67;69;69 04:33:54 INFO - PROCESS | 25166 | |10;stanford-crypto-aes;83;82;83;83;83;82;84;84;83;83 04:33:54 INFO - PROCESS | 25166 | |11;stanford-crypto-ccm;122;119;128;116;119;125;116;122;137;122 04:33:54 INFO - PROCESS | 25166 | |12;stanford-crypto-pbkdf2;149;141;148;140;146;136;140;146;155;148 04:33:54 INFO - PROCESS | 25166 | |13;stanford-crypto-sha256-iterative;71;71;73;71;72;70;71;72;69;70 04:33:54 INFO - PROCESS | 25166 | __end_tp_report 04:33:54 INFO - PROCESS | 25166 | __start_cc_report 04:33:54 INFO - PROCESS | 25166 | _x_x_mozilla_cycle_collect,1008 04:33:54 INFO - PROCESS | 25166 | __end_cc_report 04:33:54 INFO - PROCESS | 25166 | __startTimestamp1453206834953__endTimestamp 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | ------- Summary: start ------- 04:33:54 INFO - PROCESS | 25166 | Number of tests: 14 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:2.99 (2.6%) stddev-sans-first:3.02 04:33:54 INFO - PROCESS | 25166 | Values: 115.0 115.0 108.0 113.0 113.0 114.0 113.0 114.0 106.0 113.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:157.00 stddev:16.91 (10.8%) stddev-sans-first:17.76 04:33:54 INFO - PROCESS | 25166 | Values: 161.0 153.0 153.0 179.0 132.0 157.0 157.0 130.0 179.0 140.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.39 04:33:54 INFO - PROCESS | 25166 | Values: 164.0 160.0 162.0 161.0 162.0 160.0 163.0 164.0 161.0 163.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#3] audio-fft Cycles:10 Average:81.20 Median:73.00 stddev:14.30 (19.6%) stddev-sans-first:14.77 04:33:54 INFO - PROCESS | 25166 | Values: 72.0 73.0 80.0 96.0 73.0 71.0 72.0 113.0 91.0 71.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:97.00 stddev:19.27 (19.9%) stddev-sans-first:19.88 04:33:54 INFO - PROCESS | 25166 | Values: 96.0 97.0 139.0 97.0 97.0 97.0 134.0 96.0 98.0 137.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:33:54 INFO - PROCESS | 25166 | Values: 109.0 108.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:33:54 INFO - PROCESS | 25166 | Values: 146.0 147.0 147.0 146.0 146.0 148.0 146.0 147.0 148.0 147.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:33:54 INFO - PROCESS | 25166 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:68.00 stddev:3.95 (5.8%) stddev-sans-first:4.08 04:33:54 INFO - PROCESS | 25166 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 69.0 77.0 77.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 04:33:54 INFO - PROCESS | 25166 | Values: 68.0 68.0 66.0 67.0 68.0 68.0 68.0 67.0 69.0 69.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 04:33:54 INFO - PROCESS | 25166 | Values: 83.0 82.0 83.0 83.0 83.0 82.0 84.0 84.0 83.0 83.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:122.00 stddev:6.29 (5.2%) stddev-sans-first:6.67 04:33:54 INFO - PROCESS | 25166 | Values: 122.0 119.0 128.0 116.0 119.0 125.0 116.0 122.0 137.0 122.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.00 stddev:5.61 (3.8%) stddev-sans-first:5.75 04:33:54 INFO - PROCESS | 25166 | Values: 149.0 141.0 148.0 140.0 146.0 136.0 140.0 146.0 155.0 148.0 04:33:54 INFO - PROCESS | 25166 | 04:33:54 INFO - PROCESS | 25166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.15 (1.6%) stddev-sans-first:1.22 04:33:54 INFO - PROCESS | 25166 | Values: 71.0 71.0 73.0 71.0 72.0 70.0 71.0 72.0 69.0 70.0 04:33:54 INFO - PROCESS | 25166 | -------- Summary: end -------- 04:33:54 INFO - PROCESS | 25166 | 04:33:55 INFO - TEST-INFO | 25166: exit 0 04:33:55 INFO - TEST-OK | kraken | took 60477ms 04:33:55 INFO - TEST-START | v8_7 04:33:55 INFO - operating with platform_type : linux_ 04:33:55 INFO - Initialising browser for v8_7 test... 04:33:56 INFO - TEST-INFO | started process 25411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdw1ae/profile http://localhost:54734/getInfo.html) 04:34:00 INFO - PROCESS | 25411 | __metrics Screen width/height:1600/1200 04:34:00 INFO - PROCESS | 25411 | colorDepth:24 04:34:00 INFO - PROCESS | 25411 | Browser inner width/height: 1024/697 04:34:00 INFO - PROCESS | 25411 | __metrics 04:34:00 INFO - PROCESS | 25411 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:34:00 INFO - PROCESS | 25411 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:01 INFO - TEST-INFO | 25411: exit 0 04:34:01 INFO - Browser initialized. 04:34:01 INFO - Running cycle 1/1 for v8_7 test... 04:34:01 INFO - TEST-INFO | started process 25490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdw1ae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:13 INFO - PROCESS | 25490 | RSS: Main: 148983808 04:34:13 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | Cycle 1(1): loaded http://localhost:54734/tests/v8_7/run.html (next: http://localhost:54734/tests/v8_7/run.html) 04:34:35 INFO - PROCESS | 25490 | RSS: Main: 450072576 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | __start_tp_report 04:34:35 INFO - PROCESS | 25490 | _x_x_mozilla_page_load 04:34:35 INFO - PROCESS | 25490 | _x_x_mozilla_page_load_details 04:34:35 INFO - PROCESS | 25490 | |i|pagename|runs| 04:34:35 INFO - PROCESS | 25490 | |0;Richards;167.98252981689905 04:34:35 INFO - PROCESS | 25490 | |1;DeltaBlue;190.76688286913392 04:34:35 INFO - PROCESS | 25490 | |2;Encrypt;279.09572983533354 04:34:35 INFO - PROCESS | 25490 | |3;Decrypt;5246.073298429319 04:34:35 INFO - PROCESS | 25490 | |4;RayTrace;2006.0120240480962 04:34:35 INFO - PROCESS | 25490 | |5;Earley;875.7655293088364 04:34:35 INFO - PROCESS | 25490 | |6;Boyer;12500 04:34:35 INFO - PROCESS | 25490 | |7;RegExp;44173.913043478264 04:34:35 INFO - PROCESS | 25490 | |8;Splay;599.7624703087886 04:34:35 INFO - PROCESS | 25490 | |9;NavierStokes;4840.579710144928 04:34:35 INFO - PROCESS | 25490 | __end_tp_report 04:34:35 INFO - PROCESS | 25490 | __startTimestamp1453206875804__endTimestamp 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | ------- Summary: start ------- 04:34:35 INFO - PROCESS | 25490 | Number of tests: 10 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#0] Richards Cycles:1 Average:167.98 Median:167.98 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 168.0 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 190.8 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 279.1 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 5246.1 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 2006.0 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#5] Earley Cycles:1 Average:875.77 Median:875.77 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 875.8 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 12500.0 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#7] RegExp Cycles:1 Average:44173.91 Median:44173.91 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 44173.9 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#8] Splay Cycles:1 Average:599.76 Median:599.76 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 599.8 04:34:35 INFO - PROCESS | 25490 | 04:34:35 INFO - PROCESS | 25490 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:34:35 INFO - PROCESS | 25490 | Values: 4840.6 04:34:35 INFO - PROCESS | 25490 | -------- Summary: end -------- 04:34:35 INFO - PROCESS | 25490 | 04:34:36 INFO - TEST-INFO | 25490: exit 0 04:34:36 INFO - TEST-OK | v8_7 | took 40785ms 04:34:36 INFO - SUITE-END | took 1216s 04:34:37 INFO - Completed test suite (00:20:17) 04:34:37 INFO - Working with test: dromaeo_css 04:34:37 INFO - Generating results file: dromaeo_css 04:34:37 INFO - Working with test: kraken 04:34:37 INFO - Generating results file: kraken 04:34:37 INFO - javascript benchmark 04:34:37 INFO - Working with test: v8_7 04:34:37 INFO - Generating results file: v8_7 04:34:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:34:37 INFO - process_Request line: dromaeo_css 5992.56 graph.html#tests=[[72,94,35]] 04:34:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:37 INFO - process_Request line: kraken 1529.10 graph.html#tests=[[232,94,35]] 04:34:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:37 INFO - process_Request line: v8_7 18535.89 graph.html#tests=[[230,94,35]] 04:34:37 INFO - RETURN: dromaeo_css: 5992.56 04:34:37 INFO - RETURN: kraken: 1529.10 04:34:37 INFO - RETURN: v8_7: 18535.89 04:34:37 INFO - javascript benchmark 04:34:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2536.9619455708166, 2569.768720815125, 2581.819272650913, 2599.012375297387, 2599.0903183885634, 4268.3384075468275, 4317.071829556645, 4321.157374312011, 4347.60871521563, 4355.259605867002, 4362.716423432483, 4370.257056300428, 4389.561043895616, 4407.140607581523, 4455.487618923825, 4002.8198731057028, 4040.1313717550647, 4087.0599762054744, 4161.667066634677, 4170.645495132917, 3976.3637817949134, 4102.3436250199975, 4150.169966006811, 4155.148194620096, 4162.396452514384, 4003.499562554681, 4014.8594799182033, 4041.0503531670033, 4071.938920916159, 4094.549599544048, 4057.046594050396, 4062.228176646457, 4067.3085575452246, 4089.693273004507, 4094.1811637672286, 4046.898827529306, 4046.919061618751, 4049.1496785675045, 4050.432939388488, 4082.142750022499, 4179.393987871742, 4292.613664770154, 4297.527272000078, 4311.504177019651, 4401.735895846227, 4701.036287561042, 4705.952940470585, 4712.552307530779, 4718.669693121483, 4752.59602933751, 4723.6929599575915, 4730.337752714623, 4730.881727956794, 4731.36126622905, 4767.570918617306, 4305.052888364555, 4351.347297905276, 4370.7159034662645, 4375.562443755663, 4400.361947517592, 4822.807087716452, 4830.106430310404, 4837.250226214942, 4843.055604157155, 4843.297721830315, 4661.883452913704, 4663.533646635309, 4666.510016448292, 4669.252919532859, 4670.626349892001, 4613.976930115328, 4677.415323084614, 4698.224792909132, 4698.553637404441, 4735.195016847076, 4592.839250626212, 4652.441706995114, 4671.019085991979, 4672.976635116871, 4713.6464765142755, 4615.169269531517, 4652.813887444532, 4654.767261636905, 4658.301254811738, 4687.507811679793, 3931.1941052084253, 3975.6819454443576, 3986.920261594752, 4010.7393019454225, 4062.025113972625, 3528.153243221608, 3531.5938667053106, 3539.7876127431923, 3548.6628770266784, 3569.5538057742783, 4062.979685101556, 4069.613386728256, 4074.7555146691293, 4095.85664501747, 4107.158032603309, 4621.95378046222, 4623.12160689468, 4703.952960470351, 4709.929351059737, 4710.9764451177525, 4106.897327566835, 4110.8561200358445, 4112.691548133902, 4123.443335149776, 4150.626443620089, 4293.8711838644895, 4314.741115533078, 4316.330968699856, 4356.302991521341, 4369.994901172748, 4391.187630288407, 4447.199504089295, 4463.174312752151, 4480.991776850183, 4541.205289074399, 4678.719276843401, 4697.694649847749, 4706.8117275308605, 4722.881927951691, 4730.385049943486, 4456.086502267092, 4458.398116254264, 4470.061287129739, 4473.955260447354, 4509.954900450954, 4509.706869053501, 4592.104539614743, 4595.241785105421, 4600.355950166912, 4610.40064791575, 4660.6970546914345, 4674.7896344663895, 4676.181668208118, 4687.718736875799, 4727.716337019652, 4493.887652808706, 4503.459584849839, 4506.504284528633, 4507.864764057083, 4552.88617784558, 4390.473143222834, 4501.90996180068, 4503.099380123923, 4507.166174257773, 4514.187446259705, 4384.802683879169, 4410.82356705741, 4413.382126502228, 4424.093060922439, 4452.042810795565, 4552.635789136795, 4566.086782643551, 4577.473590536998, 4582.977085114553, 4620.815167393266, 4349.543297953795, 4428.535003824552, 4433.3349997499345, 4502.369668246513, 4508.481524624579], "unit": "score", "name": "dojo.html", "value": 4319.923943384542}, {"lowerIsBetter": false, "replicates": [499.4955095353692, 506.1041955738343, 518.3313525552039, 532.6644214145088, 544.7466927878537, 25125.0, 25465.74534254657, 25526.234212973617, 25529.0, 32746.345073098582, 35662.2867542649, 36072.09819754508, 36138.63861361385, 36204.45693314602, 36205.275894482096, 7688.538687678743, 7876.921230787705, 7880.724174653888, 7881.448298619099, 7884.566348850811, 7653.617319134049, 7759.146493885668, 7776.183500732426, 7780.805479862992, 7793.532388056707, 7740.4968677036095, 7828.765137045898, 7832.56920869352, 7838.059432868035, 8052.355811535063, 7870.606469676522, 7922.405819563527, 7922.762317130438, 7992.960035199787, 7995.360371170293, 7679.961600192019, 7768.300852923264, 7800.258975397328, 7816.101148367897, 7820.726274580363, 36859.07852303714, 37336.0, 37357.0, 37455.625443745485, 37482.06294842623, 2910.607068045808, 2982.522796352573, 3399.286149908522, 3467.7225821934185, 3582.283543291326, 28572.57141142864, 28601.85699071512, 28852.0, 29077.854610726812, 29450.263743406373, 3316.800991940467, 3364.226227967581, 3384.6953774160197, 3395.0632702712223, 3448.0345503259127, 213116.0, 214730.0, 214787.0, 214828.0, 215667.0, 44794.0, 46566.0, 53331.0, 53636.0, 53677.0, 57212.42787572071, 58404.707976459846, 58711.70644146837, 58761.41238587559, 58776.70611646914, 14183.21992290434, 14226.573202803933, 14259.42962281497, 14303.928480357532, 14373.568792936228, 10036.548355323883, 10449.791004179873, 10966.835497467544, 11371.545138194546, 11479.885201147881, 18522.81477185238, 18952.52618684544, 18969.525761856064, 18981.33565325207, 19014.904925475283, 7012.298770122947, 7210.351068403764, 7243.601601911945, 7311.393821892174, 7397.81505462357, 845.218173189797, 913.3058875254854, 932.3054324528134, 953.3088510829593, 1039.9012093851072, 26886.5967010495, 27142.728572714415, 27288.45423091527, 27416.725832741817, 27449.725502744717, 845.8942632170979, 892.5180402582663, 990.1484723138095, 1018.6078359831519, 1044.8328267477168, 13970.860291396955, 14020.789688154686, 14238.721804511228, 14318.212498312485, 14349.928250358891, 249959.0, 255597.0, 255669.0, 256078.0, 256218.0, 45251.0, 45251.77374113108, 45722.542774572496, 45737.542624573995, 45821.31268030982, 1231.0582404460595, 1241.5840693367822, 1247.1519366830642, 1247.8440194975628, 1256.4220458589152, 25007.374815629755, 25992.35019124537, 26315.0, 26455.33861653474, 26648.8667556661, 35343.29313413666, 36236.81881590575, 40450.59549404586, 40950.59049409468, 41732.58267417287, 159030.0, 159201.2039939793, 159870.0, 160216.0, 160546.0, 24739.25782226536, 24963.75036249687, 25027.499450010535, 25031.12391066304, 25033.624495632943, 30321.0, 33341.499877501374, 36635.81682091679, 37295.0, 37740.2451950965, 27758.861205693844, 27778.166655000383, 29381.41237175287, 29492.55761163627, 29635.407291854473, 31339.843300783352, 31382.215444613154, 31762.0, 32226.83886580552, 32314.0, 32058.19854503656, 32321.51517727189, 32379.51430728588, 32843.50734738933, 33221.83389083039, 25757.0, 29615.703842961295, 29654.406911862072, 29770.404591908475, 29845.70154298516, 23346.533069338857, 24757.752422475543, 25553.744462555136, 25563.48873022492, 25960.0], "unit": "score", "name": "ext.html", "value": 16222.16614421711}, {"lowerIsBetter": false, "replicates": [333.0923234186841, 339.24010217113675, 341.598621619597, 343.5413722680222, 344.72594287541403, 11371.431428428567, 11771.823422648667, 13845.0, 14177.653122953316, 15153.166575838324, 13896.722065558683, 14363.425462981468, 14580.343884525195, 15289.847101528982, 15419.306131224093, 4630.606398456119, 4697.9765101174535, 4840.903181936359, 4853.053654537367, 4881.877953051185, 3558.323918455485, 3737.383331750258, 5276.234945932857, 5540.335159780832, 5544.889102217953, 5347.491988261109, 5509.311336082989, 5520.227168196456, 5524.66851988882, 5614.494695477406, 5479.2602998595075, 5513.61404701671, 5518.392976772552, 5519.475649813281, 5523.7238138092935, 4750.12122757291, 4803.879903002418, 4872.951270487285, 4875.804967801319, 4877.926831097537, 17357.913210433868, 17562.560935976577, 17705.29178832845, 17759.0, 17819.376321828673, 1895.5450691833998, 1915.1094740945389, 1941.834944029759, 1997.8801271923585, 2080.3966849613744, 11699.0, 11782.941085294604, 11808.822867656907, 12037.398130093461, 12404.007679385717, 1647.6292834112348, 1663.6173680053535, 1738.452387497934, 1759.375421725282, 1812.6102887879038, 47413.0, 48628.32211021215, 48661.75669121667, 49027.26459103116, 49971.50028499705, 8835.249003834617, 8952.015278319379, 9096.636134554676, 9098.090190980849, 9168.44989300644, 11452.427378631035, 11458.427078646035, 11494.0, 11495.827562586568, 11521.942390287995, 6689.297623749533, 6966.407855332252, 7032.5077244592385, 7109.360157585842, 7233.31283528064, 6789.388954993976, 6817.147856517935, 6821.420179284816, 6838.418734407631, 6896.517243792886, 3696.168362118502, 3962.603739626072, 3986.621270979252, 3995.5016868674247, 3997.7801220932547, 1614.4995051534063, 1615.6041769766248, 1679.6304812941135, 1685.4438035448272, 1693.280355848784, 375.9830807613664, 380.0650400015992, 396.54991584551743, 825.9917400826035, 839.3327304792705, 8812.91187088121, 13310.933445332712, 14328.928355358157, 15836.366545338287, 16342.346306147621, 817.5229055960331, 856.0968178571667, 875.899271583776, 897.8967418746797, 941.9945322714868, 8203.179682031749, 8496.150384961578, 8866.246369058574, 8896.911030889609, 9014.323925705598, 434588.0, 435583.0, 446555.0, 449207.0, 449414.0, 54403.45596543984, 62305.68847155826, 64231.0, 65307.0, 65682.0, 1000.6097621927308, 1028.0798685176726, 1036.362636978253, 1039.6205385034407, 1074.0119090436817, 13819.170849749047, 13918.58244252674, 14056.297185140498, 14323.49603291681, 14373.28133593337, 20146.39560813178, 28638.856805715837, 29600.555991659712, 29775.255618609706, 31092.844535777178, 39063.60936390713, 39418.802905985285, 39636.60363396329, 39943.2011359777, 40059.799701001306, 6146.200993870768, 6210.285817131088, 6370.140031095742, 6377.7767778127545, 6742.86514269702, 7631.351335136354, 9021.639134434548, 9458.101480359355, 9694.127528522467, 10086.29395942277, 8436.831263374575, 8680.565971701515, 8691.174338437839, 8701.17338852808, 8845.071267517076, 7992.84014319722, 8537.359698022798, 8626.741197764077, 8627.580280958497, 8860.778480538038, 8650.870236946324, 8755.518446485505, 8894.42186257891, 8897.510636915033, 8951.373403861668, 6468.029795530708, 6527.902081468686, 6561.278259391368, 6608.074869518176, 6750.898736518858, 7731.729389471567, 9119.772005699911, 9241.168294853227, 9347.485888276211, 9366.718998430058], "unit": "score", "name": "jquery.html", "value": 7342.389086667776}, {"lowerIsBetter": false, "replicates": [1215.185825496917, 1370.9451621935123, 1380.9240491772955, 1483.5920121966458, 1695.6015336395938, 5803.419658034194, 6432.195975503062, 6624.86750264995, 6643.435307998826, 6649.335066493349, 6575.9342406575915, 6675.799726008216, 6699.062131301622, 6705.966470167642, 6712.060311556374, 1783.3223375117502, 1816.8819026763217, 2021.9393418197478, 2063.1128614695676, 2097.1087287902656, 2026.2199053364413, 2036.1244664794206, 2036.541778099923, 2037.5924815036979, 2037.7962203779578, 2020.3534868841975, 2023.5750492396614, 2075.792420757927, 2079.5840831833616, 2080.1991233375184, 2014.2748610500207, 2021.5148364392514, 2030.0255877179036, 2030.2995466564012, 2080.906359213839, 2012.1448384436555, 2032.5121970726918, 2036.3280117561317, 2037.022229329915, 2038.9082491287927, 6832.829179270509, 6873.381395674413, 6906.482013848981, 6910.792676219721, 6910.896336554955, 3932.7836968966694, 4077.3068578341754, 4099.405586189986, 4101.91796164075, 4104.56902025289, 2540.3522101863905, 2633.5128001319817, 2637.7626013658864, 2639.4193277478926, 2643.458091091341, 849.142366210126, 855.7860534866284, 856.9700060497853, 869.447900583128, 897.3001059173789, 9018.233450156744, 9070.092990700943, 9078.409903356194, 9078.77303067422, 9081.364304498687, 3612.4942508048894, 3708.2027364116843, 3744.9625503744614, 3773.660370566662, 3777.1501412182038, 7878.842423151505, 7881.133075361706, 7890.9605451972375, 7892.131865494791, 7892.84214315722, 4081.2041651878194, 4100.815463304159, 4101.815418306183, 4102.097538541516, 4108.91782164361, 3754.5869954305003, 3759.9060023499082, 3760.4923335349376, 3762.1347090169415, 3763.1156678180605, 2906.593076969226, 2981.567672687448, 3162.3201011782576, 3173.1115287719476, 3230.9030729078167, 1052.4632437456953, 1055.8574592430077, 1066.195022757813, 1071.6463567022863, 1083.1767856429171, 1152.1589239854952, 1153.0314535789976, 1175.9235649682744, 1177.3171560494893, 1190.9821352679717, 6276.592021518587, 6302.1492098566105, 6336.524760642878, 6341.397567231105, 6376.904346434807, 945.177695405002, 962.1965658675085, 964.9421034737938, 972.8054389122204, 1060.6393826099163, 5038.949610503848, 5074.771635276422, 5083.822066227738, 5103.081445339801, 5107.182850743863, 7606.125295590967, 7758.728444504528, 7776.8055798604355, 7814.882776758353, 7821.413393995473, 7797.571133587707, 7896.921030789734, 7902.94523423914, 7909.485883417559, 7909.960450197712, 6328.557001009885, 6371.39471750183, 6426.0, 6441.066045423388, 6468.708908099241, 6270.15352927349, 6374.617522948638, 6375.585586936834, 6379.96810015947, 6486.54594178403, 7212.531185472927, 7497.512661676974, 7501.662425190989, 7502.737404190827, 7504.962475187589, 7381.594012329373, 7658.73194438192, 7697.461177717506, 7768.805779855549, 7770.261825126604, 6052.455279024909, 6168.568200225941, 6182.412670796267, 6185.690715464299, 6187.783427580013, 6428.0, 6517.087607734826, 6539.967300163468, 6543.672816359068, 6569.868602628017, 6226.968865155645, 6293.181886354744, 6381.138546296191, 6407.455366293917, 6408.61548307103, 6179.969100154471, 6290.930541807995, 6348.269948955744, 6353.332900045429, 6394.360563943755, 6153.969230154, 6292.27638821523, 6303.086052522451, 6306.527010474141, 6310.148130002391, 5699.800506982236, 5740.655560666373, 5747.051736463437, 5747.339056008613, 5758.740856661544, 5920.171176035445, 5981.282246130492, 6024.819255422344, 6045.244344456943, 6049.727762250621], "unit": "score", "name": "mootools.html", "value": 3958.971426290883}, {"lowerIsBetter": false, "replicates": [292.9414117176565, 303.1602461182525, 304.7501049139705, 307.5555821837446, 309.85746556583956, 5221.269022336871, 5292.073887069767, 5304.098303288441, 5317.627766056377, 5331.333583302087, 5243.056249875021, 5261.552768014713, 5266.683998960065, 5267.130923397644, 5281.049411106, 3890.280298144838, 4107.363358679409, 4108.424820525129, 4135.772532510726, 4150.045489537408, 3972.066564357374, 4012.638862502374, 4111.794410279489, 4145.875623731293, 4153.418521407006, 4063.451434056394, 4096.631303182713, 4097.67218622511, 4101.712880098395, 4110.835566577333, 3859.459675645412, 3962.207558488285, 3973.4834471518516, 4090.897727556805, 4110.157417729373, 3563.251717139404, 3587.6950459211, 3607.494950706903, 3617.439296908957, 3633.854645814164, 5049.823256186052, 5070.112730272188, 5074.543291103819, 5082.1360368737405, 5082.669626474304, 4713.104510143096, 4714.339992401066, 4716.693414928019, 4719.764011799396, 4721.457032441244, 5438.646487978269, 5556.222128901957, 5560.916586251209, 5564.998300305943, 5589.105743081088, 3859.536855577349, 3897.9220415591813, 3903.394973779069, 3903.9609603904164, 3906.8437262509465, 5779.479846813807, 5836.824895253107, 5839.562032847553, 5840.269966254218, 5845.85385365365, 4018.4173294872667, 4020.557738648746, 4021.698372622065, 4022.8735953932946, 4024.738392004569, 3981.661558767479, 4066.4916885389325, 4066.8169932353117, 4078.9184216316103, 4080.0615858352744, 4670.1126785910565, 4673.953260467351, 4676.976615116902, 4677.041206552649, 4679.087577922272, 5528.474794894479, 5532.5573954083575, 5536.695481748542, 5537.390887002426, 5538.224648549206, 1421.1189062780936, 1445.992770036164, 1454.2801313349748, 1455.054214760393, 1456.3519233941006, 987.2299606306948, 989.1314592417303, 997.4264797741328, 1012.1497941728983, 1017.0338178730088, 4877.365942427462, 4894.241392584155, 4895.828645997373, 4898.559129678346, 4899.6570240083565, 5757.337906140764, 5766.596338256366, 5766.855828604234, 5777.740001699934, 5780.508656764138, 4881.9511804881495, 4892.461829198785, 4893.486183950634, 4893.608511319086, 4896.755162241873, 3027.666956634768, 3074.738647215012, 3100.1784527100335, 3100.90697279082, 3106.829124398135, 5553.527950124204, 5558.249636299129, 5558.416366281563, 5558.638688485235, 5561.193626924073, 5977.701114944235, 5981.043033114681, 5981.983062879321, 5982.282126144803, 5985.132155837379, 5497.752601132958, 5530.976769297693, 5536.446355364431, 5536.972315138399, 5542.168674698827, 5627.240322556566, 5792.247007889116, 5803.274590676166, 5807.012807822764, 5813.912791308049, 5671.574631902541, 5672.177534257427, 5675.120356344773, 5677.432256774455, 5679.74441150141, 5505.697186654773, 5520.696361699985, 5521.917171242515, 5524.558035357242, 5525.198846167203, 3908.2769687607883, 3944.165962827299, 3983.64147226751, 4006.3790112532606, 4008.4388185654616, 5797.101449275369, 5855.063189889597, 5860.38465961068, 5868.618539794899, 5871.882562348644, 5543.667379957215, 5544.417836127149, 5549.084401073777, 5550.195221692913, 5558.082916318924, 5528.336599608073, 5540.556755459635, 5542.057850165562, 5545.611807173621, 5554.055810512142, 5231.241469986754, 5400.62195646301, 5404.081306177881, 5404.135338345845, 5404.32445944257, 5389.27244821944, 5533.0, 5624.100143976944, 5639.746211420414, 5643.3792282848035, 5306.708131052829, 5389.514943654933, 5400.432954539717, 5410.107332290128, 5434.429384914527], "unit": "score", "name": "prototype.html", "value": 4189.027377027118}, {"lowerIsBetter": false, "replicates": [721.1058287723222, 739.6819367671901, 747.5178509861144, 754.4492520460064, 761.311013532753, 10746.194035447334, 10760.623378181765, 10769.407682577455, 10835.458227088653, 10895.67312980611, 10287.742806429844, 10367.533460994255, 10367.688969330913, 10368.326058806173, 10368.637097701563, 594.1889321076732, 609.2871340531567, 610.048324613602, 747.0736287004103, 760.9961950190269, 755.493819141174, 759.0208630866176, 762.5653377574785, 768.2125821033429, 768.7924260449676, 623.526120148688, 810.2990912860392, 810.6392655268407, 812.3988248695981, 813.2558708781457, 628.7296462521114, 629.238621268266, 629.886620408324, 630.0926665601542, 780.1457404142454, 594.7531774313654, 595.2083728640897, 596.2249076200922, 597.9043353063532, 598.335847209597, 10423.739406514822, 10461.320014199053, 10521.053105220566, 10526.842097368546, 10588.894111058868, 10403.479826008745, 10749.086327662159, 10965.83551246732, 11127.888721112766, 11155.0, 9263.924571599597, 9279.489628070454, 9335.206507446876, 9539.570719317579, 9617.56720947559, 3220.71013608774, 3257.3322468894057, 3288.44096503595, 3299.109240505074, 3307.5038744188323, 39330.213395732215, 39663.60336396657, 39891.60108398908, 39944.60055399438, 40065.0, 9343.299252556086, 9399.859002114974, 9524.809503809885, 9542.475163866055, 9555.952220238854, 16208.351665933467, 16229.107399092927, 16244.350225991064, 16278.43025494102, 16290.266937987819, 6522.21733391996, 6532.0, 6535.477161827042, 6577.276499585042, 6758.560693554903, 3639.563252409675, 3655.961109340147, 3741.420079887622, 3747.081964918558, 3766.3973764198145, 2468.679071720665, 2487.5398051360557, 2506.223070848043, 2508.8620125893253, 2513.3465299022387, 451.58228638509905, 453.0599007060363, 457.66361724132736, 457.81000884632505, 458.8875725447287, 448.46856475076487, 455.794892298467, 498.03629975996563, 509.37487612478606, 518.2870612625235, 7210.495265331481, 7276.96361518189, 7342.265773422615, 7499.737509187262, 7563.508371955805, 513.8150265904271, 531.3570579598729, 541.6479288462531, 545.1767830575859, 556.7800718716085, 3153.526970954375, 3213.1324542373427, 3302.4055669979152, 3336.816475093893, 3346.564946556981, 47020.0, 47569.0, 49872.251916221285, 50222.24666630004, 50232.0, 41081.58918410837, 41162.176756465306, 41202.1759564807, 41399.7930010348, 41562.0, 37347.0, 37662.0, 41557.792211039356, 42413.0, 42464.78767606142, 7843.803904902423, 7947.086085100287, 7969.043714754266, 8079.353651707732, 8126.674933002851, 30106.698933011266, 30133.397332053675, 30294.242643934078, 30786.538201927437, 30896.0, 35073.0, 35098.298034038664, 35137.47293790544, 38229.0, 38348.42477362786, 9771.0, 9863.358881672668, 9940.304178707422, 9980.31770015298, 10038.849417258602, 10765.407902565434, 10887.564497420331, 11054.668359949215, 11070.0, 11079.224454288445, 9334.813303734023, 9545.952270238604, 9590.808183836423, 9738.220942324455, 9841.60633574649, 9882.11061004513, 10369.429681367597, 10508.894911050791, 10514.842277365999, 10678.985496378142, 7870.763877083697, 10190.745231369276, 10327.586896524355, 10417.270791044553, 10590.364578125336, 7984.6406911687955, 8207.71273005442, 8795.91204087951, 8837.513936733541, 8889.155530224618, 8278.917210827814, 8378.49729016261, 8537.701180458655, 8629.654813807378, 8771.692990745549], "unit": "score", "name": "yui.html", "value": 5426.379273816549}], "name": "dromaeo_css", "value": 5992.557052288106}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 115.0, 108.0, 113.0, 113.0, 114.0, 113.0, 114.0, 106.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [161.0, 153.0, 153.0, 179.0, 132.0, 157.0, 157.0, 130.0, 179.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 154.1}, {"lowerIsBetter": true, "replicates": [164.0, 160.0, 162.0, 161.0, 162.0, 160.0, 163.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 96.0, 73.0, 71.0, 72.0, 113.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 97.0, 97.0, 97.0, 134.0, 96.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 77.0, 77.0], "unit": "score", "name": "json-parse-financial", "value": 69.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 83.0, 82.0, 84.0, 84.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 128.0, 116.0, 119.0, 125.0, 116.0, 122.0, 137.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [149.0, 141.0, 148.0, 140.0, 146.0, 136.0, 140.0, 146.0, 155.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 71.0, 72.0, 70.0, 71.0, 72.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1529.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.98252981689905], "unit": "score", "name": "Richards", "value": 210.15280599999997}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [875.7655293088364], "unit": "score", "name": "Earley", "value": 761.0062027972027}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [44173.913043478264], "unit": "score", "name": "RegExp", "value": 20.62269192913385}, {"lowerIsBetter": false, "replicates": [599.7624703087886], "unit": "score", "name": "Splay", "value": 135.87212277227718}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18535.885193564893}]} 04:34:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18535.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1529.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5992.56"}}} 04:34:37 INFO - Return code: 0 04:34:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:37 INFO - # TBPL SUCCESS # 04:34:37 INFO - Running post-action listener: _resource_record_post_action 04:34:37 INFO - Running post-run listener: _resource_record_post_run 04:34:38 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 542199808; Read time: 0; Write time: 365808 04:34:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 230223872; Read time: 0; Write time: 178756 04:34:38 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 311975936; Read time: 0; Write time: 187052 04:34:38 INFO - Running post-run listener: _upload_blobber_files 04:34:38 INFO - Blob upload gear active. 04:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:39 INFO - (blobuploader) - INFO - Done attempting. 04:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:40 INFO - (blobuploader) - INFO - Done attempting. 04:34:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:40 INFO - Return code: 0 04:34:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cbc055f6c5f2bef6c433cbaafbbf95f894765731473d4eca9f577a0bf6416a1ec2630f96747c10e0f72d1f57620b5acc28db0b38aa4d3dadf41b70213543b69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec33ffb730645d7ea47639fa2d1a64b59756a7c252813d7cb7b0dc57933c860ebce1c5ed6392f6e6519fe9380e444cfe744871a700802be6a29babe617778c68"} 04:34:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:40 INFO - Contents: 04:34:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cbc055f6c5f2bef6c433cbaafbbf95f894765731473d4eca9f577a0bf6416a1ec2630f96747c10e0f72d1f57620b5acc28db0b38aa4d3dadf41b70213543b69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec33ffb730645d7ea47639fa2d1a64b59756a7c252813d7cb7b0dc57933c860ebce1c5ed6392f6e6519fe9380e444cfe744871a700802be6a29babe617778c68"} 04:34:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:40 INFO - Copying logs to upload dir... 04:34:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.543306 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-19 04:34:40.656613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 04:34:40.660093) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cbc055f6c5f2bef6c433cbaafbbf95f894765731473d4eca9f577a0bf6416a1ec2630f96747c10e0f72d1f57620b5acc28db0b38aa4d3dadf41b70213543b69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec33ffb730645d7ea47639fa2d1a64b59756a7c252813d7cb7b0dc57933c860ebce1c5ed6392f6e6519fe9380e444cfe744871a700802be6a29babe617778c68"} build_url:https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/EY0ZbZ01Sly94T5u5dMwyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3cbc055f6c5f2bef6c433cbaafbbf95f894765731473d4eca9f577a0bf6416a1ec2630f96747c10e0f72d1f57620b5acc28db0b38aa4d3dadf41b70213543b69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec33ffb730645d7ea47639fa2d1a64b59756a7c252813d7cb7b0dc57933c860ebce1c5ed6392f6e6519fe9380e444cfe744871a700802be6a29babe617778c68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 04:34:40.688397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:34:40.688752) ========= 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=0333a256a5e4f052382dd180000001b1-1453202031.61020-194259995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004940 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:34:40.771617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 04:34:40.771956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 04:34:40.772241) ========= ========= Total master_lag: 0.28 =========