builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1452740336.68 results: success (0) buildid: 20160113172130 builduid: a29530f31712496e97a8885cff2beacd revision: fe17b0691543522ff75ecaaaba53d8e6987e35dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.677754) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.678253) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.678673) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006233 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.704892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.705791) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.720970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.721681) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.772798) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.773146) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.773559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:56.773928) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 18:58:57-- 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% 37.3M=0s 2016-01-13 18:58:57 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.411418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.201516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.202061) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018359 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:57.256336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-13 18:58:57.256971) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe17b0691543522ff75ecaaaba53d8e6987e35dd --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 fe17b0691543522ff75ecaaaba53d8e6987e35dd --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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 18:58:57,982 truncating revision to first 12 chars 2016-01-13 18:58:57,983 Setting DEBUG logging. 2016-01-13 18:58:57,983 attempt 1/10 2016-01-13 18:58:57,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe17b0691543?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 18:58:58,976 unpacking tar archive at: mozilla-central-fe17b0691543/testing/mozharness/ program finished with exit code 0 elapsedTime=1.315078 ========= master_lag: 1.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-13 18:58:59.807686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:58:59.808105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:00.099846) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:00.100245) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:00.100732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 18:59:00.101060) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:00 INFO - MultiFileLogger online at 20160113 18:59:00 in /builds/slave/test 18:59:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:59:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:00 INFO - {'append_to_log': False, 18:59:00 INFO - 'base_work_dir': '/builds/slave/test', 18:59:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:00 INFO - 'branch': 'Firefox-Non-PGO', 18:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:00 INFO - 'config_files': ('talos/linux_config.py',), 18:59:00 INFO - 'default_actions': ('clobber', 18:59:00 INFO - 'read-buildbot-config', 18:59:00 INFO - 'download-and-extract', 18:59:00 INFO - 'populate-webroot', 18:59:00 INFO - 'create-virtualenv', 18:59:00 INFO - 'install', 18:59:00 INFO - 'run-tests'), 18:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:00 INFO - 'download_minidump_stackwalk': True, 18:59:00 INFO - 'download_symbols': 'ondemand', 18:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:00 INFO - 'installer_path': 'installer.exe', 18:59:00 INFO - 'log_level': 'info', 18:59:00 INFO - 'log_name': 'talos', 18:59:00 INFO - 'log_to_console': True, 18:59:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:00 INFO - 'opt_config_files': (), 18:59:00 INFO - 'pip_index': False, 18:59:00 INFO - 'sps_profile': False, 18:59:00 INFO - 'sps_profile_interval': 0, 18:59:00 INFO - 'suite': 'dromaeojs-e10s', 18:59:00 INFO - 'system_bits': '32', 18:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:00 INFO - 'title': 'talos-linux64-ix-043', 18:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:00 INFO - 'use_talos_json': True, 18:59:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:00 INFO - 'work_dir': 'build'} 18:59:00 INFO - ##### 18:59:00 INFO - ##### Running clobber step. 18:59:00 INFO - ##### 18:59:00 INFO - Running pre-action listener: _resource_record_pre_action 18:59:00 INFO - Running main action method: clobber 18:59:00 INFO - rmtree: /builds/slave/test/build 18:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:01 INFO - Running post-action listener: _resource_record_post_action 18:59:01 INFO - ##### 18:59:01 INFO - ##### Running read-buildbot-config step. 18:59:01 INFO - ##### 18:59:01 INFO - Running pre-action listener: _resource_record_pre_action 18:59:01 INFO - Running main action method: read_buildbot_config 18:59:01 INFO - Using buildbot properties: 18:59:01 INFO - { 18:59:01 INFO - "project": "", 18:59:01 INFO - "product": "firefox", 18:59:01 INFO - "script_repo_revision": "production", 18:59:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:59:01 INFO - "repository": "", 18:59:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:59:01 INFO - "buildid": "20160113172130", 18:59:01 INFO - "pgo_build": "False", 18:59:01 INFO - "basedir": "/builds/slave/test", 18:59:01 INFO - "buildnumber": 154, 18:59:01 INFO - "slavename": "talos-linux64-ix-043", 18:59:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:59:01 INFO - "platform": "ubuntu64_hw", 18:59:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:59:01 INFO - "branch": "mozilla-central", 18:59:01 INFO - "repo_path": "mozilla-central", 18:59:01 INFO - "revision": "fe17b0691543522ff75ecaaaba53d8e6987e35dd", 18:59:01 INFO - "stage_platform": "linux64", 18:59:01 INFO - "builduid": "a29530f31712496e97a8885cff2beacd", 18:59:01 INFO - "slavebuilddir": "test" 18:59:01 INFO - } 18:59:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:59:01 INFO - Running post-action listener: _resource_record_post_action 18:59:01 INFO - ##### 18:59:01 INFO - ##### Running download-and-extract step. 18:59:01 INFO - ##### 18:59:01 INFO - Running pre-action listener: _resource_record_pre_action 18:59:01 INFO - Running main action method: download_and_extract 18:59:01 INFO - mkdir: /builds/slave/test/build/tests 18:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:01 INFO - https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/test_packages.json 18:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/test_packages.json 18:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:59:02 INFO - Downloaded 1448 bytes. 18:59:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:59:02 INFO - Using the following test package requirements: 18:59:02 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:02 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:59:02 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:59:02 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'jsshell-linux-x86_64.zip'], 18:59:02 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:59:02 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:02 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:59:02 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:59:02 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:59:02 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:02 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:59:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:02 INFO - https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:06 INFO - Downloaded 22760516 bytes. 18:59:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:59:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:59:07 INFO - Return code: 0 18:59:07 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 18:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:07 INFO - https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:09 INFO - Downloaded 22760516 bytes. 18:59:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:59:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:59:11 INFO - Return code: 0 18:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:11 INFO - https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:12 INFO - Downloaded 11132279 bytes. 18:59:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:59:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:59:13 INFO - Return code: 0 18:59:13 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')]} 18:59:13 INFO - https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:59:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/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 18:59:16 INFO - Downloaded 53908582 bytes. 18:59:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:16 INFO - mkdir: /builds/slave/test/properties 18:59:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:16 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:16 INFO - Contents: 18:59:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:16 INFO - Running post-action listener: _resource_record_post_action 18:59:16 INFO - Running post-action listener: set_extra_try_arguments 18:59:16 INFO - ##### 18:59:16 INFO - ##### Running populate-webroot step. 18:59:16 INFO - ##### 18:59:16 INFO - Running pre-action listener: _resource_record_pre_action 18:59:16 INFO - Running main action method: populate_webroot 18:59:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:16 INFO - '--tppagecycles', 18:59:16 INFO - '7'], 18:59:16 INFO - 'tests': ['tsvgm']}}, 18:59:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:59:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:59:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:59:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'tests': ['damp', 'tps']}, 18:59:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['damp', 'tps']}, 18:59:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:59:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:16 INFO - 'other': {'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'other_l64': {'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'other_nol64': {'tests': ['a11yr', 18:59:16 INFO - 'ts_paint', 18:59:16 INFO - 'tpaint', 18:59:16 INFO - 'sessionrestore', 18:59:16 INFO - 'sessionrestore_no_auto_restore']}, 18:59:16 INFO - 'svgr': {'tests': ['tsvgx', 18:59:16 INFO - 'tsvgr_opacity', 18:59:16 INFO - 'tart', 18:59:16 INFO - 'tscrollx', 18:59:16 INFO - 'cart']}, 18:59:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['tsvgx', 18:59:16 INFO - 'tsvgr_opacity', 18:59:16 INFO - 'tart', 18:59:16 INFO - 'tscrollx', 18:59:16 INFO - 'cart']}, 18:59:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'tests': ['tp5o']}, 18:59:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'talos_options': ['--e10s'], 18:59:16 INFO - 'tests': ['tp5o']}, 18:59:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'talos_options': ['--xperf_path', 18:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:16 INFO - 'tests': ['tp5n']}, 18:59:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:16 INFO - 'talos_options': ['--e10s', 18:59:16 INFO - '--xperf_path', 18:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:16 INFO - 'tests': ['tp5n']}}, 18:59:16 INFO - 'talos.zip': {'path': '', 18:59:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:16 INFO - Running post-action listener: _resource_record_post_action 18:59:16 INFO - ##### 18:59:16 INFO - ##### Running create-virtualenv step. 18:59:16 INFO - ##### 18:59:16 INFO - Running pre-action listener: _resource_record_pre_action 18:59:16 INFO - Running main action method: create_virtualenv 18:59:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:16 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 18:59:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:16 INFO - Using real prefix '/usr' 18:59:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:17 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:18 INFO - Installing pip.................done. 18:59:18 INFO - Return code: 0 18:59:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:18 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 18:59:18 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 18:59:18 INFO - Using env: {'DISPLAY': ':0', 18:59:18 INFO - 'HOME': '/home/cltbld', 18:59:18 INFO - 'LANG': 'en_US.UTF-8', 18:59:18 INFO - 'LANGUAGE': 'en_US:en', 18:59:18 INFO - 'LOGNAME': 'cltbld', 18:59:18 INFO - 'MAIL': '/var/mail/cltbld', 18:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:18 INFO - 'MOZ_NO_REMOTE': '1', 18:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:18 INFO - 'NO_EM_RESTART': '1', 18:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:18 INFO - 'PWD': '/builds/slave/test', 18:59:18 INFO - 'SHELL': '/bin/bash', 18:59:18 INFO - 'SHLVL': '1', 18:59:18 INFO - 'TERM': 'linux', 18:59:18 INFO - 'TMOUT': '86400', 18:59:18 INFO - 'USER': 'cltbld', 18:59:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:18 INFO - '_': '/tools/buildbot/bin/python'} 18:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:19 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 18:59:19 INFO - Cleaning up... 18:59:19 INFO - Return code: 0 18:59:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:59:19 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')]} 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:19 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')]} 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:19 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:19 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 18:59:19 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 18:59:19 INFO - Using env: {'DISPLAY': ':0', 18:59:19 INFO - 'HOME': '/home/cltbld', 18:59:19 INFO - 'LANG': 'en_US.UTF-8', 18:59:19 INFO - 'LANGUAGE': 'en_US:en', 18:59:19 INFO - 'LOGNAME': 'cltbld', 18:59:19 INFO - 'MAIL': '/var/mail/cltbld', 18:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:19 INFO - 'MOZ_NO_REMOTE': '1', 18:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:19 INFO - 'NO_EM_RESTART': '1', 18:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:19 INFO - 'PWD': '/builds/slave/test', 18:59:19 INFO - 'SHELL': '/bin/bash', 18:59:19 INFO - 'SHLVL': '1', 18:59:19 INFO - 'TERM': 'linux', 18:59:19 INFO - 'TMOUT': '86400', 18:59:19 INFO - 'USER': 'cltbld', 18:59:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:19 INFO - '_': '/tools/buildbot/bin/python'} 18:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:19 INFO - Downloading/unpacking psutil>=0.7.1 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:59:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:21 INFO - Installing collected packages: psutil 18:59:21 INFO - Running setup.py install for psutil 18:59:21 INFO - building 'psutil._psutil_linux' extension 18:59:21 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 18:59:21 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 18:59:21 INFO - building 'psutil._psutil_posix' extension 18:59:21 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 18:59:21 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 18:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:21 INFO - Successfully installed psutil 18:59:21 INFO - Cleaning up... 18:59:21 INFO - Return code: 0 18:59:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:59:21 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')]} 18:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:21 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')]} 18:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:21 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:21 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 18:59:21 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 18:59:21 INFO - Using env: {'DISPLAY': ':0', 18:59:21 INFO - 'HOME': '/home/cltbld', 18:59:21 INFO - 'LANG': 'en_US.UTF-8', 18:59:21 INFO - 'LANGUAGE': 'en_US:en', 18:59:21 INFO - 'LOGNAME': 'cltbld', 18:59:21 INFO - 'MAIL': '/var/mail/cltbld', 18:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:21 INFO - 'MOZ_NO_REMOTE': '1', 18:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:21 INFO - 'NO_EM_RESTART': '1', 18:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:21 INFO - 'PWD': '/builds/slave/test', 18:59:21 INFO - 'SHELL': '/bin/bash', 18:59:21 INFO - 'SHLVL': '1', 18:59:21 INFO - 'TERM': 'linux', 18:59:21 INFO - 'TMOUT': '86400', 18:59:21 INFO - 'USER': 'cltbld', 18:59:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:21 INFO - '_': '/tools/buildbot/bin/python'} 18:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:59:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:59:23 INFO - Installing collected packages: mozsystemmonitor 18:59:23 INFO - Running setup.py install for mozsystemmonitor 18:59:23 INFO - Successfully installed mozsystemmonitor 18:59:23 INFO - Cleaning up... 18:59:23 INFO - Return code: 0 18:59:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:23 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')]} 18:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 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')]} 18:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:23 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 18:59:23 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 18:59:23 INFO - Using env: {'DISPLAY': ':0', 18:59:23 INFO - 'HOME': '/home/cltbld', 18:59:23 INFO - 'LANG': 'en_US.UTF-8', 18:59:23 INFO - 'LANGUAGE': 'en_US:en', 18:59:23 INFO - 'LOGNAME': 'cltbld', 18:59:23 INFO - 'MAIL': '/var/mail/cltbld', 18:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:23 INFO - 'MOZ_NO_REMOTE': '1', 18:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:23 INFO - 'NO_EM_RESTART': '1', 18:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:23 INFO - 'PWD': '/builds/slave/test', 18:59:23 INFO - 'SHELL': '/bin/bash', 18:59:23 INFO - 'SHLVL': '1', 18:59:23 INFO - 'TERM': 'linux', 18:59:23 INFO - 'TMOUT': '86400', 18:59:23 INFO - 'USER': 'cltbld', 18:59:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:23 INFO - '_': '/tools/buildbot/bin/python'} 18:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:26 INFO - Downloading docopt-0.6.1.tar.gz 18:59:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:26 INFO - Running setup.py install for blobuploader 18:59:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:26 INFO - Running setup.py install for requests 18:59:26 INFO - Running setup.py install for docopt 18:59:27 INFO - Successfully installed blobuploader requests docopt 18:59:27 INFO - Cleaning up... 18:59:27 INFO - Return code: 0 18:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:27 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')]} 18:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:27 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')]} 18:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:27 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:27 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 18:59:27 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 18:59:27 INFO - Using env: {'DISPLAY': ':0', 18:59:27 INFO - 'HOME': '/home/cltbld', 18:59:27 INFO - 'LANG': 'en_US.UTF-8', 18:59:27 INFO - 'LANGUAGE': 'en_US:en', 18:59:27 INFO - 'LOGNAME': 'cltbld', 18:59:27 INFO - 'MAIL': '/var/mail/cltbld', 18:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:27 INFO - 'MOZ_NO_REMOTE': '1', 18:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:27 INFO - 'NO_EM_RESTART': '1', 18:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:27 INFO - 'PWD': '/builds/slave/test', 18:59:27 INFO - 'SHELL': '/bin/bash', 18:59:27 INFO - 'SHLVL': '1', 18:59:27 INFO - 'TERM': 'linux', 18:59:27 INFO - 'TMOUT': '86400', 18:59:27 INFO - 'USER': 'cltbld', 18:59:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:27 INFO - '_': '/tools/buildbot/bin/python'} 18:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:27 INFO - Running setup.py (path:/tmp/pip-xeqQsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:27 INFO - Running setup.py (path:/tmp/pip-FJWf69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:27 INFO - Running setup.py (path:/tmp/pip-Wyuac5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:27 INFO - Running setup.py (path:/tmp/pip-B5Cmur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:27 INFO - Running setup.py (path:/tmp/pip-ximren-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:27 INFO - Running setup.py (path:/tmp/pip-j5nz0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:27 INFO - Running setup.py (path:/tmp/pip-uUHi4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:27 INFO - Running setup.py (path:/tmp/pip-lqF6Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:27 INFO - Running setup.py (path:/tmp/pip-XBwLhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:27 INFO - Running setup.py (path:/tmp/pip-Ptk5CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:28 INFO - Running setup.py (path:/tmp/pip-fgezJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:28 INFO - Running setup.py (path:/tmp/pip-9BIYnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:28 INFO - Running setup.py (path:/tmp/pip-OwCCv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:28 INFO - Running setup.py (path:/tmp/pip-5NAOPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:28 INFO - Running setup.py (path:/tmp/pip-c8t3EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:28 INFO - Running setup.py (path:/tmp/pip-fOGza8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:28 INFO - Running setup.py (path:/tmp/pip-PWFUhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:28 INFO - Running setup.py install for manifestparser 18:59:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:28 INFO - Running setup.py install for mozcrash 18:59:28 INFO - Running setup.py install for mozdebug 18:59:28 INFO - Running setup.py install for mozdevice 18:59:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:28 INFO - Running setup.py install for mozfile 18:59:29 INFO - Running setup.py install for mozhttpd 18:59:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for mozinfo 18:59:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for mozInstall 18:59:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for mozleak 18:59:29 INFO - Running setup.py install for mozlog 18:59:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for moznetwork 18:59:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for mozprocess 18:59:29 INFO - Running setup.py install for mozprofile 18:59:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:29 INFO - Running setup.py install for mozrunner 18:59:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:30 INFO - Running setup.py install for mozscreenshot 18:59:30 INFO - Running setup.py install for moztest 18:59:30 INFO - Running setup.py install for mozversion 18:59:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'DISPLAY': ':0', 18:59:30 INFO - 'HOME': '/home/cltbld', 18:59:30 INFO - 'LANG': 'en_US.UTF-8', 18:59:30 INFO - 'LANGUAGE': 'en_US:en', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MAIL': '/var/mail/cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SHLVL': '1', 18:59:30 INFO - 'TERM': 'linux', 18:59:30 INFO - 'TMOUT': '86400', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - '_': '/tools/buildbot/bin/python'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:30 INFO - Running setup.py (path:/tmp/pip-d5M8jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:30 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)) 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:30 INFO - Running setup.py (path:/tmp/pip-WbJnyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:30 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)) 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:30 INFO - Running setup.py (path:/tmp/pip-nacDln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:30 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)) 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:30 INFO - Running setup.py (path:/tmp/pip-DPLInJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:30 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)) 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:30 INFO - Running setup.py (path:/tmp/pip-V9BSiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:30 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)) 18:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:30 INFO - Running setup.py (path:/tmp/pip-HPxuFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:31 INFO - Running setup.py (path:/tmp/pip-xg8mWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:31 INFO - Running setup.py (path:/tmp/pip-rjvFi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:31 INFO - Running setup.py (path:/tmp/pip-7TZkt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:31 INFO - Running setup.py (path:/tmp/pip-4hPK05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:31 INFO - Running setup.py (path:/tmp/pip-97_qm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:31 INFO - Running setup.py (path:/tmp/pip-9zus2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:31 INFO - Running setup.py (path:/tmp/pip-Xb9aLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:31 INFO - Running setup.py (path:/tmp/pip-VY_6rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:31 INFO - Running setup.py (path:/tmp/pip-x0moW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:31 INFO - Running setup.py (path:/tmp/pip-CRe8xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:31 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)) 18:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:31 INFO - Running setup.py (path:/tmp/pip-8Mac63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:31 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)) 18:59:31 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)) 18:59:31 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)) 18:59:31 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)) 18:59:31 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)) 18:59:31 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)) 18:59:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:31 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 18:59:31 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 18:59:31 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 18:59:31 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 18:59:31 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 18:59:31 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 18:59:33 INFO - Downloading blessings-1.5.1.tar.gz 18:59:33 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 18:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:33 INFO - Installing collected packages: blessings 18:59:33 INFO - Running setup.py install for blessings 18:59:33 INFO - Successfully installed blessings 18:59:33 INFO - Cleaning up... 18:59:33 INFO - Return code: 0 18:59:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:33 INFO - Reading from file tmpfile_stdout 18:59:33 INFO - Current package versions: 18:59:33 INFO - argparse == 1.2.1 18:59:33 INFO - blessings == 1.5.1 18:59:33 INFO - blobuploader == 1.2.4 18:59:33 INFO - docopt == 0.6.1 18:59:33 INFO - manifestparser == 1.1 18:59:33 INFO - mozInstall == 1.12 18:59:33 INFO - mozcrash == 0.16 18:59:33 INFO - mozdebug == 0.1 18:59:33 INFO - mozdevice == 0.48 18:59:33 INFO - mozfile == 1.2 18:59:33 INFO - mozhttpd == 0.7 18:59:33 INFO - mozinfo == 0.9 18:59:33 INFO - mozleak == 0.1 18:59:33 INFO - mozlog == 3.1 18:59:33 INFO - moznetwork == 0.27 18:59:33 INFO - mozprocess == 0.22 18:59:33 INFO - mozprofile == 0.28 18:59:33 INFO - mozrunner == 6.11 18:59:33 INFO - mozscreenshot == 0.1 18:59:33 INFO - mozsystemmonitor == 0.0 18:59:33 INFO - moztest == 0.7 18:59:33 INFO - mozversion == 1.4 18:59:33 INFO - psutil == 3.1.1 18:59:33 INFO - requests == 1.2.3 18:59:33 INFO - wsgiref == 0.1.2 18:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:33 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:33 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 18:59:33 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 18:59:33 INFO - Using env: {'DISPLAY': ':0', 18:59:33 INFO - 'HOME': '/home/cltbld', 18:59:33 INFO - 'LANG': 'en_US.UTF-8', 18:59:33 INFO - 'LANGUAGE': 'en_US:en', 18:59:33 INFO - 'LOGNAME': 'cltbld', 18:59:33 INFO - 'MAIL': '/var/mail/cltbld', 18:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:33 INFO - 'MOZ_NO_REMOTE': '1', 18:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:33 INFO - 'NO_EM_RESTART': '1', 18:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:33 INFO - 'PWD': '/builds/slave/test', 18:59:33 INFO - 'SHELL': '/bin/bash', 18:59:33 INFO - 'SHLVL': '1', 18:59:33 INFO - 'TERM': 'linux', 18:59:33 INFO - 'TMOUT': '86400', 18:59:33 INFO - 'USER': 'cltbld', 18:59:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:33 INFO - '_': '/tools/buildbot/bin/python'} 18:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 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)) 18:59:34 INFO - Cleaning up... 18:59:34 INFO - Return code: 0 18:59:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:34 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')]} 18:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:34 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')]} 18:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:34 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:34 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 18:59:34 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 18:59:34 INFO - Using env: {'DISPLAY': ':0', 18:59:34 INFO - 'HOME': '/home/cltbld', 18:59:34 INFO - 'LANG': 'en_US.UTF-8', 18:59:34 INFO - 'LANGUAGE': 'en_US:en', 18:59:34 INFO - 'LOGNAME': 'cltbld', 18:59:34 INFO - 'MAIL': '/var/mail/cltbld', 18:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:34 INFO - 'MOZ_NO_REMOTE': '1', 18:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:34 INFO - 'NO_EM_RESTART': '1', 18:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:34 INFO - 'PWD': '/builds/slave/test', 18:59:34 INFO - 'SHELL': '/bin/bash', 18:59:34 INFO - 'SHLVL': '1', 18:59:34 INFO - 'TERM': 'linux', 18:59:34 INFO - 'TMOUT': '86400', 18:59:34 INFO - 'USER': 'cltbld', 18:59:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:34 INFO - '_': '/tools/buildbot/bin/python'} 18:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:34 INFO - Downloading/unpacking jsonschema 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:36 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 18:59:36 INFO - Downloading/unpacking functools32 (from jsonschema) 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:36 INFO - warning: no files found matching '*.txt' 18:59:36 INFO - no previously-included directories found matching 'build' 18:59:36 INFO - no previously-included directories found matching 'dist' 18:59:36 INFO - no previously-included directories found matching '.git*' 18:59:36 INFO - Installing collected packages: jsonschema, functools32 18:59:36 INFO - Running setup.py install for functools32 18:59:36 INFO - warning: no files found matching '*.txt' 18:59:36 INFO - no previously-included directories found matching 'build' 18:59:36 INFO - no previously-included directories found matching 'dist' 18:59:36 INFO - no previously-included directories found matching '.git*' 18:59:36 INFO - Successfully installed jsonschema functools32 18:59:36 INFO - Cleaning up... 18:59:36 INFO - Return code: 0 18:59:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:36 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 0x7ffb67f8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a97dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, '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': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', '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 18:59:36 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 18:59:36 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 18:59:36 INFO - Using env: {'DISPLAY': ':0', 18:59:36 INFO - 'HOME': '/home/cltbld', 18:59:36 INFO - 'LANG': 'en_US.UTF-8', 18:59:36 INFO - 'LANGUAGE': 'en_US:en', 18:59:36 INFO - 'LOGNAME': 'cltbld', 18:59:36 INFO - 'MAIL': '/var/mail/cltbld', 18:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:36 INFO - 'MOZ_NO_REMOTE': '1', 18:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:36 INFO - 'NO_EM_RESTART': '1', 18:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:36 INFO - 'PWD': '/builds/slave/test', 18:59:36 INFO - 'SHELL': '/bin/bash', 18:59:36 INFO - 'SHLVL': '1', 18:59:36 INFO - 'TERM': 'linux', 18:59:36 INFO - 'TMOUT': '86400', 18:59:36 INFO - 'USER': 'cltbld', 18:59:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:36 INFO - '_': '/tools/buildbot/bin/python'} 18:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:36 INFO - Downloading/unpacking flake8 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:36 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 18:59:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:59:38 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 18:59:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:59:38 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 18:59:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:38 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 18:59:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:59:39 INFO - no previously-included directories found matching 'docs/_build' 18:59:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:59:39 INFO - Running setup.py install for pep8 18:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:59:39 INFO - no previously-included directories found matching 'docs/_build' 18:59:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:59:39 INFO - Cleaning up... 18:59:39 INFO - Return code: 0 18:59:39 INFO - Running post-action listener: _resource_record_post_action 18:59:39 INFO - Running post-action listener: _start_resource_monitoring 18:59:39 INFO - Starting resource monitoring. 18:59:39 INFO - ##### 18:59:39 INFO - ##### Running install step. 18:59:39 INFO - ##### 18:59:39 INFO - Running pre-action listener: _resource_record_pre_action 18:59:39 INFO - Running main action method: install 18:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:39 INFO - Reading from file tmpfile_stdout 18:59:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:39 INFO - Reading from file tmpfile_stdout 18:59:39 INFO - Output received: 18:59:39 INFO - Usage: mozinstall [options] installer 18:59:39 INFO - Options: 18:59:39 INFO - -h, --help show this help message and exit 18:59:39 INFO - -d DEST, --destination=DEST 18:59:39 INFO - Directory to install application into. [default: 18:59:39 INFO - "/builds/slave/test"] 18:59:39 INFO - --app=APP Application being installed. [default: firefox] 18:59:39 INFO - mkdir: /builds/slave/test/build/application 18:59:39 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'] 18:59:39 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 18:59:55 INFO - Reading from file tmpfile_stdout 18:59:55 INFO - Output received: 18:59:55 INFO - /builds/slave/test/build/application/firefox/firefox 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - ##### 18:59:55 INFO - ##### Running run-tests step. 18:59:55 INFO - ##### 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: run_tests 18:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:55 INFO - Python 2.7.3 18:59:55 INFO - Return code: 0 18:59:55 INFO - grabbing minidump binary from tooltool 18:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:55 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 0x2b2a3d0>, '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 0x2a95ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:55 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 18:59:55 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 18:59:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:55 INFO - Return code: 0 18:59:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:59:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:59:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:59:56 INFO - Return code: 0 18:59:56 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:59:56 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:59:56 INFO - Using env: {'DISPLAY': ':0', 18:59:56 INFO - 'HOME': '/home/cltbld', 18:59:56 INFO - 'LANG': 'en_US.UTF-8', 18:59:56 INFO - 'LANGUAGE': 'en_US:en', 18:59:56 INFO - 'LOGNAME': 'cltbld', 18:59:56 INFO - 'MAIL': '/var/mail/cltbld', 18:59:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:56 INFO - 'MOZ_NO_REMOTE': '1', 18:59:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:56 INFO - 'NO_EM_RESTART': '1', 18:59:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:56 INFO - 'PWD': '/builds/slave/test', 18:59:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:56 INFO - 'SHELL': '/bin/bash', 18:59:56 INFO - 'SHLVL': '1', 18:59:56 INFO - 'TERM': 'linux', 18:59:56 INFO - 'TMOUT': '86400', 18:59:56 INFO - 'USER': 'cltbld', 18:59:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1452740336.401001-671196808', 18:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:56 INFO - '_': '/tools/buildbot/bin/python'} 18:59:56 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:59:56 INFO - mozversion application_buildid: 20160113172130 18:59:56 INFO - mozversion application_changeset: fe17b0691543522ff75ecaaaba53d8e6987e35dd 18:59:56 INFO - mozversion application_display_name: Nightly 18:59:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:56 INFO - mozversion application_name: Firefox 18:59:56 INFO - mozversion application_remotingname: firefox 18:59:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:56 INFO - mozversion application_vendor: Mozilla 18:59:56 INFO - mozversion application_version: 46.0a1 18:59:56 INFO - mozversion platform_buildid: 20160113172130 18:59:56 INFO - mozversion platform_changeset: fe17b0691543522ff75ecaaaba53d8e6987e35dd 18:59:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:56 INFO - mozversion platform_version: 46.0a1 18:59:56 INFO - using testdate: 1452740396 18:59:56 INFO - actual date: 1452740396 18:59:56 INFO - starting webserver on 'localhost:33132' 18:59:56 INFO - SUITE-START | Running 3 tests 18:59:56 INFO - TEST-START | dromaeo_css 18:59:56 INFO - operating with platform_type : linux_ 18:59:56 INFO - Initialising browser for dromaeo_css test... 18:59:56 INFO - TEST-INFO | started process 3991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPUd7Jo/profile http://localhost:33132/getInfo.html) 19:00:00 INFO - PROCESS | 3991 | 19:00:00 INFO - PROCESS | 3991 | (process:4074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:01 INFO - PROCESS | 3991 | __metrics Screen width/height:1600/1200 19:00:01 INFO - PROCESS | 3991 | colorDepth:24 19:00:01 INFO - PROCESS | 3991 | Browser inner width/height: 1024/697 19:00:01 INFO - PROCESS | 3991 | __metrics 19:00:01 INFO - PROCESS | 3991 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:00:02 INFO - TEST-INFO | 3991: exit 0 19:00:02 INFO - Browser initialized. 19:00:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:02 INFO - TEST-INFO | started process 4123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPUd7Jo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:04 INFO - PROCESS | 4123 | 19:00:04 INFO - PROCESS | 4123 | (process:4179): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:14 INFO - PROCESS | 4123 | RSS: Main: 149852160 19:00:14 INFO - PROCESS | 4123 | 19:01:04 INFO - PROCESS | 4123 | 1452740464549 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] 19:03:14 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33132/tests/dromaeo/cssquery-ext.html) 19:03:15 INFO - PROCESS | 4123 | RSS: Main: 154054656 19:03:15 INFO - PROCESS | 4123 | 19:06:17 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-ext.html (next: http://localhost:33132/tests/dromaeo/cssquery-jquery.html) 19:06:18 INFO - PROCESS | 4123 | RSS: Main: 153767936 19:06:18 INFO - PROCESS | 4123 | 19:09:20 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33132/tests/dromaeo/cssquery-mootools.html) 19:09:20 INFO - PROCESS | 4123 | RSS: Main: 152494080 19:09:20 INFO - PROCESS | 4123 | 19:12:22 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33132/tests/dromaeo/cssquery-prototype.html) 19:12:23 INFO - PROCESS | 4123 | RSS: Main: 150499328 19:12:23 INFO - PROCESS | 4123 | 19:15:26 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33132/tests/dromaeo/cssquery-yui.html) 19:15:26 INFO - PROCESS | 4123 | RSS: Main: 150163456 19:15:26 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | Cycle 1(1): loaded http://localhost:33132/tests/dromaeo/cssquery-yui.html (next: http://localhost:33132/tests/dromaeo/cssquery-dojo.html) 19:18:29 INFO - PROCESS | 4123 | RSS: Main: 152887296 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | __start_tp_report 19:18:29 INFO - PROCESS | 4123 | _x_x_mozilla_page_load 19:18:29 INFO - PROCESS | 4123 | _x_x_mozilla_page_load_details 19:18:29 INFO - PROCESS | 4123 | |i|pagename|runs| 19:18:29 INFO - PROCESS | 4123 | |0;dojo.html;2653.854038027908;2655.973440265597;2682.262377846092;2689.2066840282114;2703.7836973042154;4495.1459222747735;4531.388262584546;4571.405717256756;4584.3352713856475;4592.357070010193;4532.116237333721;4533.750643714594;4547.24970379887;4580.152671755719;4669.6731228814;4195;4243.511996120447;4320.56794320567;4327.459067616548;4372.234858899696;112.24579056633021;4215.831366745327;4257.297545904922;4292.055747735493;4333.1117120990275;4215.283401821683;4237.7669228192435;4248.299030659938;4263.467066616673;4264.083222107246;4227.661787057028;4228.957710422887;4233.23801715691;4269.252880745888;4280.293751530994;4104.610062044101;4211.136716973013;4278.6363159131515;4283.892902677427;4309.202797482476;4424.712393694432;4494.123645889053;4500.234960056766;4511.887202819923;4537.160625284333;4816.397950256218;4823.782929768169;4826.61387089032;4856.125897338477;4892.290617860391;4790.568848803624;4832.9758351208375;4854.029194161147;4860.659753817235;4902;4511.661625378109;4552.795124219451;4565.840195593139;4566.315052742082;4577.5880170784785;4953.0589188054155;4972.552470277692;4976.253561965734;4986.351774269394;5035.395752509722;4667.136579732693;4671.789769460383;4762.166620841339;4767.332573439721;4772.069446457907;4844.515548445127;4862.805487780449;4865.416150062015;4874.098291816025;4902;4789.712617242907;4811.182099043171;4816.783244753994;4820.108279968217;4875.731834749052;4653.883652908637;4730.834420795256;4740.691855029412;4749.3588365570895;4805.519448055166;4005.35914253718;4039.8586049488126;4045.3122969095325;4070.470838790938;4074.5110586729784;3532.3994920863515;3573.26748016656;3603.963960360415;3618.2582570572968;3637.217998130415;4145.984233862723;4218.8523401680795;4264.360345948133;4283.31466965284;4290.141971605692;4815.662903596784;4821.059893320768;4837.105135549935;4866.902661946741;4879.194932836113;4175.290200665833;4210.642095421924;4212.410262563244;4244.660427165819;4249.490061192615;4312.223799716081;4339.891502712458;4357.4988876279;4379;4396.538363471854;4575.062112267044;4595.126925884071;4602.21762300403;4627.074585083064;4679.064187162649;4699.553542413465;4778.665493415428;4798.568128868418;4859.659823812299;4871.561559459666;4519.914598398565;4612.815487380467;4617.307403889444;4651.604613607746;4659.254519276899;4767.046590681808;4768.76156192196;4816.34979277807;4818.494058123846;4858.975705121452;4720.45714742809;4816;4822.324874517501;4887;4889.657723959289;4768.356271903249;4784.449788274393;4793.520647935318;4793.832215872428;4804.615630749462;4740.146773580788;4766.737829419415;4766.761661916821;4770.492293283726;4808.3989501312335;4570.565796249351;4580.610648094949;4614.492405835288;4662.090892276109;4668.229742092517;4714.9292760609305;4737.620990320835;4738.739369334719;4753;4787.4494433140635;4572.971081506635;4584.19776539111;4595.540445955377;4599.862004139881;4635.351050852951 19:18:29 INFO - PROCESS | 4123 | |1;ext.html;477.95937345325643;493.7531234382806;512.2572270208198;517.565245194037;522.3340241192479;24126.51746965062;31888.521672174906;32103.35793284133;32166.67833321669;32230.194245143826;34435.82782086086;35024.824875875645;35026.824865875635;35034.124146896276;35079.64920350796;7500.887486687704;7687.769956806912;7687.884681729778;7696.615169241543;7701.383889288843;7432.554046757185;7500.249975002511;7522.833960736068;7532.322091011808;7551.24487551246;7538.660760265774;7549.094108706963;7550.131734850507;7591.3926885849;7594.962025189866;7479.5886226257535;7503.287187717158;7520.887186692204;7703.768886933401;7731.574763388011;7648.158702542716;7728.7681369559;7803.531788092732;7806;7822.6088695564995;36201;36591.4511282331;36953.630463695554;37020;37107.814460927526;2790.5489145644356;2857.6142220800134;2992.5511173323957;3518.469465782393;3547.308274886398;27263.182104536896;27799.722002779916;27807.721922780715;28149.718502814914;28507;3391.525186473871;3393.592768867727;3410.4543273076188;3449.3618680544178;3532.0993146747414;210026;210753;211600;213933;214294;48469;51212.487875121515;51332;51473.22790158151;51503.484965149866;42863.571364285955;55497.167542486895;56791.14813277804;56820;56866.715666421405;13272.601821945356;13495.325233738275;13572.728545429234;13577.932110339385;13638.727225455634;10065.949670251603;10111.393316400892;10137.746556336004;10187.337823041478;10307.072363487172;16728.749068763977;16950.23723932426;17085.57286067858;17086.145692715316;17786.46640600784;7286.854262914712;7396.149442814038;7564.659590318449;7607.695692172362;7627.694892204249;854.5342788180457;893.4951752259952;939.0843927170954;1039.1478987230398;1086.3590481615884;27697.584536231974;28167;29453.26366840846;29457.263568410533;29470.557941630894;953.2945620241111;956;961.711486554045;1037.0407373179778;1077.5097330714507;12368.010559155246;12477.376131193585;13540.526081587097;14171.291435428187;14438.711225775636;249534.00931981258;255022;255299;255723;256445;44588.55411445909;44817.32774008392;44857.55142448599;44861.55138448639;44868.775656121514;1236.116176933497;1241.76406482768;1247.3326770177912;1248.182440501473;1266.9176503527242;24644.38389040288;25387;25498;25537.361565961;25651.230463086136;37546;38120.42819357656;38204;38211.42682859815;38362.80818595889;241846;244582;245025;245845;246159;26438.471230574894;28141.623005239504;28522.286942825765;28539.714602854536;28555.42889142164;32712.182195445304;32743.508847367786;32975;33670.49494257637;33871.15322116967;27461;28368.858155709913;28902.710972890844;30147.547786783656;31653.20866978344;30105.849470752506;30774.230644234074;30857.382852343275;31209.53185702171;31285;31380.372392551566;31480.84259578779;31586.842065789522;31714;31897.202569935936;26476.338091547866;27199.72800271972;27769;27923.860380698778;27975;22483.662745059166;22528.774712253322;22670.886645566665;22697.546049079258;22770.43073923165 19:18:29 INFO - PROCESS | 4123 | |2;jquery.html;344.83964956295324;346.2054584728049;348.62174540623414;348.89533140057995;353.5492247384583;13712.108712933652;13899.776035834257;14917.925410372933;15140.77288840667;15563.066216027019;14569.635759106028;14694.63263418415;15184.31670574824;15206.163660998669;15255.466058687949;4392.363107349441;5067;5092.083424983502;5096.668716533413;5107;4834.6374021948495;4952.455229924705;5073.543381095701;5079.4412614612365;5082.79668813247;5012.097822391968;5036.269740887569;5839.737211825478;6106.114613381057;6112;6004;6023.427774361428;6024.48791852693;6458.515611329122;6490.967545162292;5931.584789064767;6169;6246.031865060922;6249.5625306228585;6255.812325630193;17923.551911202194;18091.819081809277;18648.720269195972;18874.52813679669;18948.67359284837;1723.414039226669;1814.4919422561704;1849.2510533234063;1876.8873867567854;2049.231538173185;13159.802602960963;13322.800157997637;13516.189028658311;13646.021326907641;13765;1836.8163183681525;1844.3729132095018;1869.5232715657555;1884.3028079610494;1933.574613585009;57215.427845721424;57236.42763572353;57896.594756651204;58367.70816145977;58679;14313.28433578317;14684;14707.779383309258;14809.555713328617;14913.627159321104;21552.892235538722;21559.46101347479;21757.782422175576;21851.562968740534;21867.343979680318;8206.671733130608;8347.081820999685;8369.204925532065;8419.536925469158;8485.490870547786;6791.4906382021545;6819.045333653293;6822.181338239443;6829.829254268683;6834.521583489108;7315.30504602062;7380.261973802684;7404.518706284074;7404.851902961911;7484.513506622052;2934.7358737713707;2995.1164406500134;3029.803062800911;3082.784205105621;3145.386649603351;775.2751177648917;808.720991258015;874.6239117179547;956.1155930764015;986.5807032011367;14264.714705705828;15074.924625376803;15517.379304827906;15878.206089695468;16410.261538230807;765.8506591214771;778.2412148155616;793.6190628498238;821.5604651511412;834.1283358889974;8258.463199891989;8285.088640249567;8386.371022173362;8454.704085357105;8458.8477059107;433453;434417;436034;438348;443625;61249.693751530955;62558;62802.37197628056;63367.68316158482;63439.36560634427;1013.5742987945081;1044.368157264859;1045.2160879340342;1054.1303424674675;1100.5047728522036;13486;13616.114952528054;13622.93188534051;13690.794638080237;14031.228282444563;26996.865015674797;27004.05485807987;27167.184984450498;27474.862625686743;27878.58182127229;35022.64977350194;36189.27621447609;40116.59883401129;40385.1922961545;40811.79594102011;6208.317085120723;6435.388638079375;6526.24948130971;6633.436157926631;6724.394804467622;7601.619919004138;8060.959695201486;10253.33353332031;10266.230032747424;10326.380417174994;7765.961170194113;8581.798548203382;8610.870836937325;8644.740657780276;8968.865467018131;8672.132786721277;9056.366054376394;9329.58016889228;9472.100150485692;9527;8974.461532308082;9065.909340906506;9267.76830579241;9361.906380936103;9768.902310976799;6501.772437964649;6605.438537724347;6620.205575330991;6647.102641143577;6698.196216454056;8248.958755206186;8263.173682631688;8872.64509419616;8879.334049946408;9008.684696035607 19:18:29 INFO - PROCESS | 4123 | |3;mootools.html;1370.5477192526466;1380.7790753479442;1489.9553013409602;1682.1925475771623;1694.0851939952418;6834.555753876;6921.515493915428;7012.053372794671;7080.3273688999525;7112.324329188726;7094.822629434267;7122.8575428491395;7185.2814718528125;7200.639968001605;7239.348458638721;2020.151536354731;2066.1735305877696;2066.6693329067352;2067.069818581637;2071.0680193912726;2062.257587268582;2074.9273775417864;2085.8331333493284;2093.7592176899625;2094.2670065477037;2018.7072874433272;2070.3788863340937;2072.616565935299;2073.0360382422173;2093.518490747129;2035.297822251321;2055.0033233881554;2059.567490826928;2063.0509965416004;2066.4937090412795;2008.0762849089435;2034.8473864460077;2037.5822956294073;2040.4898775306174;2042.234162189179;6869.690863911136;6939.340762627542;6958.234594194634;6958.47811414146;6962.477814163907;4105.7331273467125;4206.032612499112;4234.491860976672;4236.04688944988;4259.1268789897995;2647.9867600662064;2650.0989663514497;2700.230434326227;2701.9054333098247;2703.4863375958503;812.2446125103651;823.2919689067397;839.5382539603255;858.4463021351194;868.9695860644847;9382.906170938271;9584.66453674118;9594.9520252399;9682.46746428946;9690.224782017422;3754.3617585010616;3817.7900215488417;3856.82644281008;3860.208657225262;3930.0371409004406;8410.285125764256;8421.073681894986;8447.45091569046;8449.070602233749;8476.364272679573;4172.561881002512;4174.582541745801;4180.832766689298;4193.22425351311;4220.177065472203;3746.83139258734;3763.7553559018575;3791.962080379216;3793.317202903504;3800.600936901641;3347.246869454353;3349.815760133216;3365.6297807241185;3370.8651653934057;3420.9144771380415;1037.6990672704983;1076.8007918535095;1077.757504561483;1078.3907092492716;1078.6440474643348;849.6601359456267;871.4205053639386;887.6538150121457;920.4937284493502;952.9184375733593;6527.477801775942;6598.076269322299;6627.834304142435;6635.336466353423;6645.767398141042;1020.806046851096;1040.8386700061503;1041.5365162502615;1050.9054185123375;1059.422614675004;4965.453800081988;4986.501349864984;4999.075171093359;4999.800007999712;5024.020316038411;8298.087210406851;8471.279941204943;8540.701075462453;8602.956985215034;8837.337199710048;8697.130286971253;8706.6517339307;8734.213920747163;8755.693550725695;8805.867911981326;6786.3892249697765;6814.8637027260165;6853.560752241985;6969.895451568231;6994.195667498201;6426.678666066585;6470.22357317125;6474.773382931575;6477.578957367756;6511.804645860631;7685.5004424712215;7771.844563108819;7836.177201394;7840.490368126054;7929.643166057426;7887.605619718876;7945.205479452008;8004.679812807422;8146.9185308148535;8172.5913704315735;6079.939200608114;6169.444749972524;6170.938290617037;6208.161898143873;6223.439890409885;6268.968655156695;6419.743210271724;6421.678916054085;6426.550141490051;6536.803895883131;6178.443940045418;6185.443310102112;6274.843128921813;6356.841078972878;6442.452391546583;5601.011640867433;6099.024156135175;6137.048757442603;6153.230846144232;6227.844303892439;6365.872682546231;6369.172007638977;6376.808695739135;6388.36116388376;6400.615963042233;5990.7304171311525;6052.243469566304;6056.06131049688;6058.848528786815;6111.908321375094;5670.716464176692;5768.336641286306;5801.3908539602735;5806.535477161732;5820.097884827858 19:18:29 INFO - PROCESS | 4123 | |4;prototype.html;307.5248740695625;312.0342539839197;312.7482376686766;314.3367494586422;326.5542534440488;5461.262729531512;5490.094134467818;5588.6646801191855;5618.157276408536;5623.831285061445;5378.515933565978;5421.647592906458;5439.755211015504;5458.781648734046;5476.534494567966;4074.7962601869935;4085.1829634073156;4095.1604920991126;4185.958140418587;4186.644135248507;4150.792460376984;4154.43915071466;4154.97922510387;4158.168366326731;4165.937510937339;4168.395582640515;4181.121964387482;4191.622753952143;4191.790410479479;4197.349410841309;4186.995121170928;4192.182524407742;4200.138971510848;4228.746275223466;4229.048464095585;3526.7883926964464;3609.9639003610155;3642.1258897864586;3654.7076233901225;3656.542932133483;5158.53573178412;5287.365516138049;5304.761285742151;5322.0952438085615;5322.840314790563;4877.707337559757;4882.145624515695;4885.462599114095;4894.192458244385;4895.902081958377;5779.248697669318;5806.5645076619;5819.912701309484;5826.82519524415;5838.766449342022;3934.7639141651307;4020.839166433339;4024.1146947671464;4031.133306339151;4035.3745169498775;6016.1878146450545;6021.939780602182;6057.787977420813;6081.27024757032;6089.543284253655;4120.814563344657;4122.319817230184;4131.442255295557;4143.482064741907;4146.067134894624;4205.411242426063;4215.283401821697;4222.641075508554;4223.387608796707;4230.957690423118;4572.95427045732;4643.558861908114;4828.903421931542;4830.227163653799;4844.515548445127;5719;5756;5769.711514424262;5779.537636989031;5792.7103644818435;1422.4665750343622;1436.6911114110308;1437.1664434628099;1439.3954539093397;1440.3950340856866;964.7250533597891;992.8659630949729;1002.9849552256723;1012.1346248957183;1026.9229807764298;5074.974625126851;5105;5105.744712764347;5120.436751957282;5128.948710512847;6004.909926351108;6027.57806953509;6036.879262414727;6042.791441711675;6044.697765111727;5065.797368105234;5072.923906141411;5084.110280700863;5119.718415487184;5130.948690513047;3153.385089907446;3231.9030429087165;3250.5286733423995;3255.7395408367274;3270.9509357359657;5634.154876768517;5641.323041235078;5654.15187721845;5686.0333743263745;5695.117256825199;6194.81415557534;6198.752049918043;6202.72087756052;6211.254649442096;6211.720472578745;5513.641613295123;5626.2967129108865;5646.322441307069;5678.659280443187;5682.488576028178;5969.492593129633;5986.610870293417;6003.969980150071;6004.369541198112;6013.789517366871;5888.381719919518;5903.350631430625;5903.616264942765;5903.763849446146;5916.852078698067;5646.181303711021;5665.575081868794;5674.773009079756;5678.74445649955;5683.3748287687495;3885.747426417274;3993.520777506718;3997.140614767839;4005.1388951375593;4025.2352053109817;5923.763049477972;5955.702214889152;6000.669963152069;6007.137787285956;6020.458158765732;5812.651240925558;5820.621659592113;5823.505002074701;5838.883222335445;5842.269716285465;5825.70871456434;5832.387599302012;5837.970810145922;5838.503727183237;5839.299284085767;5609.74756135983;5672;5694.971525142348;5707.258056452634;5707.942920570741;5861.179434879035;5869.413058694267;5876.911846322394;5880.50015748649;5897.41025897424;5662.207290979184;5686.459786320293;5690.118031705092;5692.971535142464;5700.629459085146 19:18:29 INFO - PROCESS | 4123 | |5;yui.html;755.2296657409443;761.177927837935;764.4037650632505;773.8955241042461;787.1498781316179;11096.667099987004;11254.49354779035;11274.549018039268;11275.492602832872;11298.661040168787;11954.940225298884;11976.820347694791;12041;12051.879481205186;12058.155929084967;758.5183408535564;763.6105586151075;781.7263957614846;783.4476693930793;785.2814674572759;778.7469072551444;779.4232268121577;779.6062988190955;780.8204113054001;782.4679218131669;815.7715839564931;817.5585184000662;817.5912043978011;817.9631916563769;820.327331588098;805.1385018030738;806.72168102005;808.7533302342783;809.4455298120777;811.2293321344687;597.175897261776;601.3685630088434;601.4616917858535;603.1314906534576;604.4137186928672;11803.11476639247;11887.40562971848;11920.642380728592;11924.105692073043;11938.104642151786;11419.371934543597;11696.532138714527;11767.764644707058;11783.823242651368;12263.386830658432;9517.191038761714;9634.373765705206;9779.413235205839;9805.705828825146;9809.705708828747;3095.5666206731075;3137.262743255333;3142.151619062863;3186.4105140549073;3226.0160651001434;41646.37530437076;42063.7896810514;42092;42193;42245.57754422447;9110.274940771253;9128.58921348541;9167.770805729777;9218.287989777275;9348.1119293667;15992;16021.759673604905;16031.278592463366;16034.919825400799;16049.037057776572;6277.340879207617;6617.205935287796;6670.39966403026;6725.529212955144;6845.418139458102;3540.2565461253425;3559.7864128152396;3612.2233719749856;3640.2355505344176;3671.4125739882024;2513.710923243814;2523.041244327144;2533.2020413569667;2538.4796116796015;2545.503626792795;484.6244160775427;485.3084354794404;491.67303743010496;495.4995454590889;499.2261993909426;431.29698591296614;529.1797713543991;558.0732619580085;577.7804434314934;586.6919867069737;7418.740344088039;7561.924380756122;7571.962140189264;7581.166071732105;7617.466777325645;459.9287110497878;506.05115408608856;568.3605943313772;574.5690731951037;647.934148326001;3665.725070619714;3678.2459595782802;3748.981255093762;3756.530433695788;3759.1353988582778;46357.768211159404;46396.30405543919;46854;47090.764546177736;48256.758716206896;40407.39388909169;40713.38929916054;40914.38628420517;40982.385264220466;45771.542284577394;39396.212075758325;41344.1731165375;41540.58459415428;42282.36576451355;42369.788151059045;7707.691692332244;7975.4018448615425;7980.12218655959;8162.10216876155;8274.462159959825;29473.410531789672;30150;30584.84707576448;30644.84677576598;30696.07911762651;34913.65086349104;35380.823095884356;36936.81531592432;37119.628803712694;37584.62415375921;10273.86987431367;10275.126614237874;10351.120154786928;10451.68644940653;10549.156067514734;11368.147388946027;11377.886221138015;11379.54481820751;11425.31448113116;11532.769344612892;10435.16518678519;10712.678619641423;10718.088962437969;10727.195460340661;10969.670909872397;10915.508802103766;10940;11016.889831101586;11042.613508527484;11331.773364532499;10344.53449594755;11159.27464714791;11176.944115279372;11188;11191.832122518332;9064.773380665272;9171.40385874916;9267.351285409957;9273.443593384418;9604.567794449405;8245.95877020611;8680.175383338572;8730.65077396897;9405.670801521914;9418.481983490974 19:18:29 INFO - PROCESS | 4123 | __end_tp_report 19:18:29 INFO - PROCESS | 4123 | __start_cc_report 19:18:29 INFO - PROCESS | 4123 | _x_x_mozilla_cycle_collect,340 19:18:29 INFO - PROCESS | 4123 | __end_cc_report 19:18:29 INFO - PROCESS | 4123 | __startTimestamp1452741509390__endTimestamp 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | ------- Summary: start ------- 19:18:29 INFO - PROCESS | 4123 | Number of tests: 6 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#0] dojo.html Cycles:165 Average:4473.81 Median:4599.86 stddev:557.31 (12.1%) stddev-sans-first:540.42 19:18:29 INFO - PROCESS | 4123 | Values: 2653.9 2656.0 2682.3 2689.2 2703.8 4495.1 4531.4 4571.4 4584.3 4592.4 4532.1 4533.8 4547.2 4580.2 4669.7 4195.0 4243.5 4320.6 4327.5 4372.2 112.2 4215.8 4257.3 4292.1 4333.1 4215.3 4237.8 4248.3 4263.5 4264.1 4227.7 4229.0 4233.2 4269.3 4280.3 4104.6 4211.1 4278.6 4283.9 4309.2 4424.7 4494.1 4500.2 4511.9 4537.2 4816.4 4823.8 4826.6 4856.1 4892.3 4790.6 4833.0 4854.0 4860.7 4902.0 4511.7 4552.8 4565.8 4566.3 4577.6 4953.1 4972.6 4976.3 4986.4 5035.4 4667.1 4671.8 4762.2 4767.3 4772.1 4844.5 4862.8 4865.4 4874.1 4902.0 4789.7 4811.2 4816.8 4820.1 4875.7 4653.9 4730.8 4740.7 4749.4 4805.5 4005.4 4039.9 4045.3 4070.5 4074.5 3532.4 3573.3 3604.0 3618.3 3637.2 4146.0 4218.9 4264.4 4283.3 4290.1 4815.7 4821.1 4837.1 4866.9 4879.2 4175.3 4210.6 4212.4 4244.7 4249.5 4312.2 4339.9 4357.5 4379.0 4396.5 4575.1 4595.1 4602.2 4627.1 4679.1 4699.6 4778.7 4798.6 4859.7 4871.6 4519.9 4612.8 4617.3 4651.6 4659.3 4767.0 4768.8 4816.3 4818.5 4859.0 4720.5 4816.0 4822.3 4887.0 4889.7 4768.4 4784.4 4793.5 4793.8 4804.6 4740.1 4766.7 4766.8 4770.5 4808.4 4570.6 4580.6 4614.5 4662.1 4668.2 4714.9 4737.6 4738.7 4753.0 4787.4 4573.0 4584.2 4595.5 4599.9 4635.4 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#1] ext.html Cycles:180 Average:38781.33 Median:31683.60 stddev:61925.66 (195.5%) stddev-sans-first:62032.59 19:18:29 INFO - PROCESS | 4123 | Values: 478.0 493.8 512.3 517.6 522.3 24126.5 31888.5 32103.4 32166.7 32230.2 34435.8 35024.8 35026.8 35034.1 35079.6 7500.9 7687.8 7687.9 7696.6 7701.4 7432.6 7500.2 7522.8 7532.3 7551.2 7538.7 7549.1 7550.1 7591.4 7595.0 7479.6 7503.3 7520.9 7703.8 7731.6 7648.2 7728.8 7803.5 7806.0 7822.6 36201.0 36591.5 36953.6 37020.0 37107.8 2790.5 2857.6 2992.6 3518.5 3547.3 27263.2 27799.7 27807.7 28149.7 28507.0 3391.5 3393.6 3410.5 3449.4 3532.1 210026.0 210753.0 211600.0 213933.0 214294.0 48469.0 51212.5 51332.0 51473.2 51503.5 42863.6 55497.2 56791.1 56820.0 56866.7 13272.6 13495.3 13572.7 13577.9 13638.7 10065.9 10111.4 10137.7 10187.3 10307.1 16728.7 16950.2 17085.6 17086.1 17786.5 7286.9 7396.1 7564.7 7607.7 7627.7 854.5 893.5 939.1 1039.1 1086.4 27697.6 28167.0 29453.3 29457.3 29470.6 953.3 956.0 961.7 1037.0 1077.5 12368.0 12477.4 13540.5 14171.3 14438.7 249534.0 255022.0 255299.0 255723.0 256445.0 44588.6 44817.3 44857.6 44861.6 44868.8 1236.1 1241.8 1247.3 1248.2 1266.9 24644.4 25387.0 25498.0 25537.4 25651.2 37546.0 38120.4 38204.0 38211.4 38362.8 241846.0 244582.0 245025.0 245845.0 246159.0 26438.5 28141.6 28522.3 28539.7 28555.4 32712.2 32743.5 32975.0 33670.5 33871.2 27461.0 28368.9 28902.7 30147.5 31653.2 30105.8 30774.2 30857.4 31209.5 31285.0 31380.4 31480.8 31586.8 31714.0 31897.2 26476.3 27199.7 27769.0 27923.9 27975.0 22483.7 22528.8 22670.9 22697.5 22770.4 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#2] jquery.html Cycles:180 Average:24375.54 Median:5081.12 stddev:71349.35 (1404.2%) stddev-sans-first:71526.68 19:18:29 INFO - PROCESS | 4123 | Values: 344.8 346.2 348.6 348.9 353.5 13712.1 13899.8 14917.9 15140.8 15563.1 14569.6 14694.6 15184.3 15206.2 15255.5 4392.4 5067.0 5092.1 5096.7 5107.0 4834.6 4952.5 5073.5 5079.4 5082.8 5012.1 5036.3 5839.7 6106.1 6112.0 6004.0 6023.4 6024.5 6458.5 6491.0 5931.6 6169.0 6246.0 6249.6 6255.8 17923.6 18091.8 18648.7 18874.5 18948.7 1723.4 1814.5 1849.3 1876.9 2049.2 13159.8 13322.8 13516.2 13646.0 13765.0 1836.8 1844.4 1869.5 1884.3 1933.6 57215.4 57236.4 57896.6 58367.7 58679.0 14313.3 14684.0 14707.8 14809.6 14913.6 21552.9 21559.5 21757.8 21851.6 21867.3 8206.7 8347.1 8369.2 8419.5 8485.5 6791.5 6819.0 6822.2 6829.8 6834.5 7315.3 7380.3 7404.5 7404.9 7484.5 2934.7 2995.1 3029.8 3082.8 3145.4 775.3 808.7 874.6 956.1 986.6 14264.7 15074.9 15517.4 15878.2 16410.3 765.9 778.2 793.6 821.6 834.1 8258.5 8285.1 8386.4 8454.7 8458.8 433453.0 434417.0 436034.0 438348.0 443625.0 61249.7 62558.0 62802.4 63367.7 63439.4 1013.6 1044.4 1045.2 1054.1 1100.5 13486.0 13616.1 13622.9 13690.8 14031.2 26996.9 27004.1 27167.2 27474.9 27878.6 35022.6 36189.3 40116.6 40385.2 40811.8 6208.3 6435.4 6526.2 6633.4 6724.4 7601.6 8061.0 10253.3 10266.2 10326.4 7766.0 8581.8 8610.9 8644.7 8968.9 8672.1 9056.4 9329.6 9472.1 9527.0 8974.5 9065.9 9267.8 9361.9 9768.9 6501.8 6605.4 6620.2 6647.1 6698.2 8249.0 8263.2 8872.6 8879.3 9008.7 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#3] mootools.html Cycles:180 Average:4946.70 Median:6170.19 stddev:2588.38 (41.9%) stddev-sans-first:2581.69 19:18:29 INFO - PROCESS | 4123 | Values: 1370.5 1380.8 1490.0 1682.2 1694.1 6834.6 6921.5 7012.1 7080.3 7112.3 7094.8 7122.9 7185.3 7200.6 7239.3 2020.2 2066.2 2066.7 2067.1 2071.1 2062.3 2074.9 2085.8 2093.8 2094.3 2018.7 2070.4 2072.6 2073.0 2093.5 2035.3 2055.0 2059.6 2063.1 2066.5 2008.1 2034.8 2037.6 2040.5 2042.2 6869.7 6939.3 6958.2 6958.5 6962.5 4105.7 4206.0 4234.5 4236.0 4259.1 2648.0 2650.1 2700.2 2701.9 2703.5 812.2 823.3 839.5 858.4 869.0 9382.9 9584.7 9595.0 9682.5 9690.2 3754.4 3817.8 3856.8 3860.2 3930.0 8410.3 8421.1 8447.5 8449.1 8476.4 4172.6 4174.6 4180.8 4193.2 4220.2 3746.8 3763.8 3792.0 3793.3 3800.6 3347.2 3349.8 3365.6 3370.9 3420.9 1037.7 1076.8 1077.8 1078.4 1078.6 849.7 871.4 887.7 920.5 952.9 6527.5 6598.1 6627.8 6635.3 6645.8 1020.8 1040.8 1041.5 1050.9 1059.4 4965.5 4986.5 4999.1 4999.8 5024.0 8298.1 8471.3 8540.7 8603.0 8837.3 8697.1 8706.7 8734.2 8755.7 8805.9 6786.4 6814.9 6853.6 6969.9 6994.2 6426.7 6470.2 6474.8 6477.6 6511.8 7685.5 7771.8 7836.2 7840.5 7929.6 7887.6 7945.2 8004.7 8146.9 8172.6 6079.9 6169.4 6170.9 6208.2 6223.4 6269.0 6419.7 6421.7 6426.6 6536.8 6178.4 6185.4 6274.8 6356.8 6442.5 5601.0 6099.0 6137.0 6153.2 6227.8 6365.9 6369.2 6376.8 6388.4 6400.6 5990.7 6052.2 6056.1 6058.8 6111.9 5670.7 5768.3 5801.4 5806.5 5820.1 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#4] prototype.html Cycles:180 Average:4787.08 Median:5449.27 stddev:1427.33 (26.2%) stddev-sans-first:1391.17 19:18:29 INFO - PROCESS | 4123 | Values: 307.5 312.0 312.7 314.3 326.6 5461.3 5490.1 5588.7 5618.2 5623.8 5378.5 5421.6 5439.8 5458.8 5476.5 4074.8 4085.2 4095.2 4186.0 4186.6 4150.8 4154.4 4155.0 4158.2 4165.9 4168.4 4181.1 4191.6 4191.8 4197.3 4187.0 4192.2 4200.1 4228.7 4229.0 3526.8 3610.0 3642.1 3654.7 3656.5 5158.5 5287.4 5304.8 5322.1 5322.8 4877.7 4882.1 4885.5 4894.2 4895.9 5779.2 5806.6 5819.9 5826.8 5838.8 3934.8 4020.8 4024.1 4031.1 4035.4 6016.2 6021.9 6057.8 6081.3 6089.5 4120.8 4122.3 4131.4 4143.5 4146.1 4205.4 4215.3 4222.6 4223.4 4231.0 4573.0 4643.6 4828.9 4830.2 4844.5 5719.0 5756.0 5769.7 5779.5 5792.7 1422.5 1436.7 1437.2 1439.4 1440.4 964.7 992.9 1003.0 1012.1 1026.9 5075.0 5105.0 5105.7 5120.4 5128.9 6004.9 6027.6 6036.9 6042.8 6044.7 5065.8 5072.9 5084.1 5119.7 5130.9 3153.4 3231.9 3250.5 3255.7 3271.0 5634.2 5641.3 5654.2 5686.0 5695.1 6194.8 6198.8 6202.7 6211.3 6211.7 5513.6 5626.3 5646.3 5678.7 5682.5 5969.5 5986.6 6004.0 6004.4 6013.8 5888.4 5903.4 5903.6 5903.8 5916.9 5646.2 5665.6 5674.8 5678.7 5683.4 3885.7 3993.5 3997.1 4005.1 4025.2 5923.8 5955.7 6000.7 6007.1 6020.5 5812.7 5820.6 5823.5 5838.9 5842.3 5825.7 5832.4 5838.0 5838.5 5839.3 5609.7 5672.0 5695.0 5707.3 5707.9 5861.2 5869.4 5876.9 5880.5 5897.4 5662.2 5686.5 5690.1 5693.0 5700.6 19:18:29 INFO - PROCESS | 4123 | 19:18:29 INFO - PROCESS | 4123 | [#5] yui.html Cycles:180 Average:12078.70 Median:42219.29 stddev:13362.03 (31.6%) stddev-sans-first:13372.45 19:18:29 INFO - PROCESS | 4123 | Values: 755.2 761.2 764.4 773.9 787.1 11096.7 11254.5 11274.5 11275.5 11298.7 11954.9 11976.8 12041.0 12051.9 12058.2 758.5 763.6 781.7 783.4 785.3 778.7 779.4 779.6 780.8 782.5 815.8 817.6 817.6 818.0 820.3 805.1 806.7 808.8 809.4 811.2 597.2 601.4 601.5 603.1 604.4 11803.1 11887.4 11920.6 11924.1 11938.1 11419.4 11696.5 11767.8 11783.8 12263.4 9517.2 9634.4 9779.4 9805.7 9809.7 3095.6 3137.3 3142.2 3186.4 3226.0 41646.4 42063.8 42092.0 42193.0 42245.6 9110.3 9128.6 9167.8 9218.3 9348.1 15992.0 16021.8 16031.3 16034.9 16049.0 6277.3 6617.2 6670.4 6725.5 6845.4 3540.3 3559.8 3612.2 3640.2 3671.4 2513.7 2523.0 2533.2 2538.5 2545.5 484.6 485.3 491.7 495.5 499.2 431.3 529.2 558.1 577.8 586.7 7418.7 7561.9 7572.0 7581.2 7617.5 459.9 506.1 568.4 574.6 647.9 3665.7 3678.2 3749.0 3756.5 3759.1 46357.8 46396.3 46854.0 47090.8 48256.8 40407.4 40713.4 40914.4 40982.4 45771.5 39396.2 41344.2 41540.6 42282.4 42369.8 7707.7 7975.4 7980.1 8162.1 8274.5 29473.4 30150.0 30584.8 30644.8 30696.1 34913.7 35380.8 36936.8 37119.6 37584.6 10273.9 10275.1 10351.1 10451.7 10549.2 11368.1 11377.9 11379.5 11425.3 11532.8 10435.2 10712.7 10718.1 10727.2 10969.7 10915.5 10940.0 11016.9 11042.6 11331.8 10344.5 11159.3 11176.9 11188.0 11191.8 9064.8 9171.4 9267.4 9273.4 9604.6 8246.0 8680.2 8730.7 9405.7 9418.5 19:18:29 INFO - PROCESS | 4123 | -------- Summary: end -------- 19:18:29 INFO - PROCESS | 4123 | 19:18:30 INFO - TEST-INFO | 4123: exit 0 19:18:30 INFO - TEST-OK | dromaeo_css | took 1113517ms 19:18:30 INFO - TEST-START | kraken 19:18:30 INFO - operating with platform_type : linux_ 19:18:30 INFO - Initialising browser for kraken test... 19:18:30 INFO - TEST-INFO | started process 4364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKRAsT/profile http://localhost:33132/getInfo.html) 19:18:34 INFO - PROCESS | 4364 | 19:18:34 INFO - PROCESS | 4364 | (process:4433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:18:35 INFO - PROCESS | 4364 | __metrics Screen width/height:1600/1200 19:18:35 INFO - PROCESS | 4364 | colorDepth:24 19:18:35 INFO - PROCESS | 4364 | Browser inner width/height: 1024/697 19:18:35 INFO - PROCESS | 4364 | __metrics 19:18:35 INFO - PROCESS | 4364 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:18:36 INFO - TEST-INFO | 4364: exit 0 19:18:36 INFO - Browser initialized. 19:18:36 INFO - Running cycle 1/1 for kraken test... 19:18:36 INFO - TEST-INFO | started process 4483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKRAsT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:37 INFO - PROCESS | 4483 | 19:18:37 INFO - PROCESS | 4483 | (process:4542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:18:48 INFO - PROCESS | 4483 | RSS: Main: 150040576 19:18:48 INFO - PROCESS | 4483 | 19:18:50 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33132/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:51 INFO - PROCESS | 4483 | RSS: Main: 149663744 19:18:51 INFO - PROCESS | 4483 | 19:18:54 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33132/tests/kraken/driver.html?testName=audio-dft) 19:18:54 INFO - PROCESS | 4483 | RSS: Main: 153214976 19:18:54 INFO - PROCESS | 4483 | 19:18:57 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33132/tests/kraken/driver.html?testName=audio-fft) 19:18:58 INFO - PROCESS | 4483 | RSS: Main: 146112512 19:18:58 INFO - PROCESS | 4483 | 19:19:00 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33132/tests/kraken/driver.html?testName=audio-oscillator) 19:19:00 INFO - PROCESS | 4483 | RSS: Main: 147677184 19:19:00 INFO - PROCESS | 4483 | 19:19:03 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33132/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:03 INFO - PROCESS | 4483 | RSS: Main: 147320832 19:19:03 INFO - PROCESS | 4483 | 19:19:06 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33132/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:07 INFO - PROCESS | 4483 | RSS: Main: 148914176 19:19:07 INFO - PROCESS | 4483 | 19:19:10 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33132/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:11 INFO - PROCESS | 4483 | RSS: Main: 148520960 19:19:11 INFO - PROCESS | 4483 | 19:19:14 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33132/tests/kraken/driver.html?testName=json-parse-financial) 19:19:15 INFO - PROCESS | 4483 | RSS: Main: 149225472 19:19:15 INFO - PROCESS | 4483 | 19:19:16 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33132/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:17 INFO - PROCESS | 4483 | RSS: Main: 149590016 19:19:17 INFO - PROCESS | 4483 | 19:19:19 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:19 INFO - PROCESS | 4483 | RSS: Main: 148295680 19:19:19 INFO - PROCESS | 4483 | 19:19:22 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:22 INFO - PROCESS | 4483 | RSS: Main: 148451328 19:19:22 INFO - PROCESS | 4483 | 19:19:25 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:25 INFO - PROCESS | 4483 | RSS: Main: 148754432 19:19:25 INFO - PROCESS | 4483 | 19:19:28 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:29 INFO - PROCESS | 4483 | RSS: Main: 149774336 19:19:29 INFO - PROCESS | 4483 | 19:19:30 INFO - PROCESS | 4483 | Cycle 1(1): loaded http://localhost:33132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33132/tests/kraken/driver.html?testName=ai-astar) 19:19:31 INFO - PROCESS | 4483 | RSS: Main: 148832256 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | __start_tp_report 19:19:31 INFO - PROCESS | 4483 | _x_x_mozilla_page_load 19:19:31 INFO - PROCESS | 4483 | _x_x_mozilla_page_load_details 19:19:31 INFO - PROCESS | 4483 | |i|pagename|runs| 19:19:31 INFO - PROCESS | 4483 | |0;ai-astar;119;112;118;118;117;129;114;114;115;115 19:19:31 INFO - PROCESS | 4483 | |1;audio-beat-detection;153;135;160;168;138;161;160;131;168;132 19:19:31 INFO - PROCESS | 4483 | |2;audio-dft;164;163;163;164;166;166;164;161;165;161 19:19:31 INFO - PROCESS | 4483 | |3;audio-fft;73;73;74;74;136;75;72;74;73;89 19:19:31 INFO - PROCESS | 4483 | |4;audio-oscillator;97;98;141;97;98;97;140;99;98;133 19:19:31 INFO - PROCESS | 4483 | |5;imaging-gaussian-blur;111;110;111;110;110;110;112;110;110;111 19:19:31 INFO - PROCESS | 4483 | |6;imaging-darkroom;148;148;148;147;149;148;148;148;148;148 19:19:31 INFO - PROCESS | 4483 | |7;imaging-desaturate;96;97;96;96;103;96;96;97;96;96 19:19:31 INFO - PROCESS | 4483 | |8;json-parse-financial;74;74;73;73;75;73;72;72;73;71 19:19:31 INFO - PROCESS | 4483 | |9;json-stringify-tinderbox;70;66;71;67;72;67;67;66;67;67 19:19:31 INFO - PROCESS | 4483 | |10;stanford-crypto-aes;91;86;88;86;85;86;84;85;85;84 19:19:31 INFO - PROCESS | 4483 | |11;stanford-crypto-ccm;126;125;125;130;123;124;124;138;122;124 19:19:31 INFO - PROCESS | 4483 | |12;stanford-crypto-pbkdf2;143;167;158;152;153;141;158;159;157;145 19:19:31 INFO - PROCESS | 4483 | |13;stanford-crypto-sha256-iterative;71;77;75;73;73;72;72;72;71;72 19:19:31 INFO - PROCESS | 4483 | __end_tp_report 19:19:31 INFO - PROCESS | 4483 | __start_cc_report 19:19:31 INFO - PROCESS | 4483 | _x_x_mozilla_cycle_collect,787 19:19:31 INFO - PROCESS | 4483 | __end_cc_report 19:19:31 INFO - PROCESS | 4483 | __startTimestamp1452741571157__endTimestamp 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | ------- Summary: start ------- 19:19:31 INFO - PROCESS | 4483 | Number of tests: 14 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.50 stddev:4.72 (4.0%) stddev-sans-first:4.96 19:19:31 INFO - PROCESS | 4483 | Values: 119.0 112.0 118.0 118.0 117.0 129.0 114.0 114.0 115.0 115.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:160.00 stddev:15.01 (9.4%) stddev-sans-first:15.90 19:19:31 INFO - PROCESS | 4483 | Values: 153.0 135.0 160.0 168.0 138.0 161.0 160.0 131.0 168.0 132.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.77 (1.1%) stddev-sans-first:1.87 19:19:31 INFO - PROCESS | 4483 | Values: 164.0 163.0 163.0 164.0 166.0 166.0 164.0 161.0 165.0 161.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:19.84 (26.8%) stddev-sans-first:20.82 19:19:31 INFO - PROCESS | 4483 | Values: 73.0 73.0 74.0 74.0 136.0 75.0 72.0 74.0 73.0 89.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:97.50 stddev:19.58 (20.1%) stddev-sans-first:20.21 19:19:31 INFO - PROCESS | 4483 | Values: 97.0 98.0 141.0 97.0 98.0 97.0 140.0 99.0 98.0 133.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:19:31 INFO - PROCESS | 4483 | Values: 111.0 110.0 111.0 110.0 110.0 110.0 112.0 110.0 110.0 111.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 19:19:31 INFO - PROCESS | 4483 | Values: 148.0 148.0 148.0 147.0 149.0 148.0 148.0 148.0 148.0 148.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:2.18 (2.3%) stddev-sans-first:2.29 19:19:31 INFO - PROCESS | 4483 | Values: 96.0 97.0 96.0 96.0 103.0 96.0 96.0 97.0 96.0 96.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#8] json-parse-financial Cycles:10 Average:73.00 Median:73.00 stddev:1.15 (1.6%) stddev-sans-first:1.17 19:19:31 INFO - PROCESS | 4483 | Values: 74.0 74.0 73.0 73.0 75.0 73.0 72.0 72.0 73.0 71.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:2.17 19:19:31 INFO - PROCESS | 4483 | Values: 70.0 66.0 71.0 67.0 72.0 67.0 67.0 66.0 67.0 67.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.11 (2.5%) stddev-sans-first:1.24 19:19:31 INFO - PROCESS | 4483 | Values: 91.0 86.0 88.0 86.0 85.0 86.0 84.0 85.0 85.0 84.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.00 stddev:4.70 (3.8%) stddev-sans-first:4.99 19:19:31 INFO - PROCESS | 4483 | Values: 126.0 125.0 125.0 130.0 123.0 124.0 124.0 138.0 122.0 124.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:157.50 stddev:8.21 (5.2%) stddev-sans-first:7.81 19:19:31 INFO - PROCESS | 4483 | Values: 143.0 167.0 158.0 152.0 153.0 141.0 158.0 159.0 157.0 145.0 19:19:31 INFO - PROCESS | 4483 | 19:19:31 INFO - PROCESS | 4483 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:1.87 (2.6%) stddev-sans-first:1.87 19:19:31 INFO - PROCESS | 4483 | Values: 71.0 77.0 75.0 73.0 73.0 72.0 72.0 72.0 71.0 72.0 19:19:31 INFO - PROCESS | 4483 | -------- Summary: end -------- 19:19:31 INFO - PROCESS | 4483 | 19:19:32 INFO - TEST-INFO | 4483: exit 0 19:19:32 INFO - TEST-OK | kraken | took 62096ms 19:19:32 INFO - TEST-START | v8_7 19:19:32 INFO - operating with platform_type : linux_ 19:19:32 INFO - Initialising browser for v8_7 test... 19:19:32 INFO - TEST-INFO | started process 4770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVDc2cO/profile http://localhost:33132/getInfo.html) 19:19:36 INFO - PROCESS | 4770 | 19:19:36 INFO - PROCESS | 4770 | (process:4845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:37 INFO - PROCESS | 4770 | __metrics Screen width/height:1600/1200 19:19:37 INFO - PROCESS | 4770 | colorDepth:24 19:19:37 INFO - PROCESS | 4770 | Browser inner width/height: 1024/697 19:19:37 INFO - PROCESS | 4770 | __metrics 19:19:37 INFO - PROCESS | 4770 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:19:38 INFO - TEST-INFO | 4770: exit 0 19:19:38 INFO - Browser initialized. 19:19:38 INFO - Running cycle 1/1 for v8_7 test... 19:19:38 INFO - TEST-INFO | started process 4894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVDc2cO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:39 INFO - PROCESS | 4894 | 19:19:39 INFO - PROCESS | 4894 | (process:4951): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:50 INFO - PROCESS | 4894 | RSS: Main: 150175744 19:19:50 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:33132/tests/v8_7/run.html (next: http://localhost:33132/tests/v8_7/run.html) 19:20:12 INFO - PROCESS | 4894 | RSS: Main: 144949248 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | __start_tp_report 19:20:12 INFO - PROCESS | 4894 | _x_x_mozilla_page_load 19:20:12 INFO - PROCESS | 4894 | _x_x_mozilla_page_load_details 19:20:12 INFO - PROCESS | 4894 | |i|pagename|runs| 19:20:12 INFO - PROCESS | 4894 | |0;Richards;170.9986320109439 19:20:12 INFO - PROCESS | 4894 | |1;DeltaBlue;188.11136192626034 19:20:12 INFO - PROCESS | 4894 | |2;Encrypt;278.78449958182324 19:20:12 INFO - PROCESS | 4894 | |3;Decrypt;5306.878306878307 19:20:12 INFO - PROCESS | 4894 | |4;RayTrace;1071.8113612004288 19:20:12 INFO - PROCESS | 4894 | |5;Earley;729.3946024799417 19:20:12 INFO - PROCESS | 4894 | |6;Boyer;12345.67901234568 19:20:12 INFO - PROCESS | 4894 | |7;RegExp;43340.425531914894 19:20:12 INFO - PROCESS | 4894 | |8;Splay;617.283950617284 19:20:12 INFO - PROCESS | 4894 | |9;NavierStokes;4835.748792270531 19:20:12 INFO - PROCESS | 4894 | __end_tp_report 19:20:12 INFO - PROCESS | 4894 | __startTimestamp1452741612912__endTimestamp 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | ------- Summary: start ------- 19:20:12 INFO - PROCESS | 4894 | Number of tests: 10 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#0] Richards Cycles:1 Average:171.00 Median:171.00 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 171.0 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 188.1 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 278.8 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 5306.9 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 1071.8 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 729.4 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 12345.7 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#7] RegExp Cycles:1 Average:43340.43 Median:43340.43 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 43340.4 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 617.3 19:20:12 INFO - PROCESS | 4894 | 19:20:12 INFO - PROCESS | 4894 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:20:12 INFO - PROCESS | 4894 | Values: 4835.7 19:20:12 INFO - PROCESS | 4894 | -------- Summary: end -------- 19:20:12 INFO - PROCESS | 4894 | 19:20:13 INFO - TEST-INFO | 4894: exit 0 19:20:13 INFO - TEST-OK | v8_7 | took 41699ms 19:20:13 INFO - SUITE-END | took 1217s 19:20:13 INFO - Completed test suite (00:20:17) 19:20:13 INFO - Working with test: dromaeo_css 19:20:13 INFO - Generating results file: dromaeo_css 19:20:13 INFO - Working with test: kraken 19:20:13 INFO - Generating results file: kraken 19:20:13 INFO - javascript benchmark 19:20:13 INFO - Working with test: v8_7 19:20:13 INFO - Generating results file: v8_7 19:20:13 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 19:20:13 INFO - process_Request line: dromaeo_css 6234.28 graph.html#tests=[[72,94,43]] 19:20:13 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:14 INFO - process_Request line: kraken 1557.10 graph.html#tests=[[232,94,43]] 19:20:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:14 INFO - process_Request line: v8_7 20082.10 graph.html#tests=[[230,94,43]] 19:20:14 INFO - RETURN: dromaeo_css: 6234.28 19:20:14 INFO - RETURN: kraken: 1557.10 19:20:14 INFO - RETURN: v8_7: 20082.10 19:20:14 INFO - javascript benchmark 19:20:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2653.854038027908, 2655.973440265597, 2682.262377846092, 2689.2066840282114, 2703.7836973042154, 4495.1459222747735, 4531.388262584546, 4571.405717256756, 4584.3352713856475, 4592.357070010193, 4532.116237333721, 4533.750643714594, 4547.24970379887, 4580.152671755719, 4669.6731228814, 4195.0, 4243.511996120447, 4320.56794320567, 4327.459067616548, 4372.234858899696, 112.24579056633021, 4215.831366745327, 4257.297545904922, 4292.055747735493, 4333.1117120990275, 4215.283401821683, 4237.7669228192435, 4248.299030659938, 4263.467066616673, 4264.083222107246, 4227.661787057028, 4228.957710422887, 4233.23801715691, 4269.252880745888, 4280.293751530994, 4104.610062044101, 4211.136716973013, 4278.6363159131515, 4283.892902677427, 4309.202797482476, 4424.712393694432, 4494.123645889053, 4500.234960056766, 4511.887202819923, 4537.160625284333, 4816.397950256218, 4823.782929768169, 4826.61387089032, 4856.125897338477, 4892.290617860391, 4790.568848803624, 4832.9758351208375, 4854.029194161147, 4860.659753817235, 4902.0, 4511.661625378109, 4552.795124219451, 4565.840195593139, 4566.315052742082, 4577.5880170784785, 4953.0589188054155, 4972.552470277692, 4976.253561965734, 4986.351774269394, 5035.395752509722, 4667.136579732693, 4671.789769460383, 4762.166620841339, 4767.332573439721, 4772.069446457907, 4844.515548445127, 4862.805487780449, 4865.416150062015, 4874.098291816025, 4902.0, 4789.712617242907, 4811.182099043171, 4816.783244753994, 4820.108279968217, 4875.731834749052, 4653.883652908637, 4730.834420795256, 4740.691855029412, 4749.3588365570895, 4805.519448055166, 4005.35914253718, 4039.8586049488126, 4045.3122969095325, 4070.470838790938, 4074.5110586729784, 3532.3994920863515, 3573.26748016656, 3603.963960360415, 3618.2582570572968, 3637.217998130415, 4145.984233862723, 4218.8523401680795, 4264.360345948133, 4283.31466965284, 4290.141971605692, 4815.662903596784, 4821.059893320768, 4837.105135549935, 4866.902661946741, 4879.194932836113, 4175.290200665833, 4210.642095421924, 4212.410262563244, 4244.660427165819, 4249.490061192615, 4312.223799716081, 4339.891502712458, 4357.4988876279, 4379.0, 4396.538363471854, 4575.062112267044, 4595.126925884071, 4602.21762300403, 4627.074585083064, 4679.064187162649, 4699.553542413465, 4778.665493415428, 4798.568128868418, 4859.659823812299, 4871.561559459666, 4519.914598398565, 4612.815487380467, 4617.307403889444, 4651.604613607746, 4659.254519276899, 4767.046590681808, 4768.76156192196, 4816.34979277807, 4818.494058123846, 4858.975705121452, 4720.45714742809, 4816.0, 4822.324874517501, 4887.0, 4889.657723959289, 4768.356271903249, 4784.449788274393, 4793.520647935318, 4793.832215872428, 4804.615630749462, 4740.146773580788, 4766.737829419415, 4766.761661916821, 4770.492293283726, 4808.3989501312335, 4570.565796249351, 4580.610648094949, 4614.492405835288, 4662.090892276109, 4668.229742092517, 4714.9292760609305, 4737.620990320835, 4738.739369334719, 4753.0, 4787.4494433140635, 4572.971081506635, 4584.19776539111, 4595.540445955377, 4599.862004139881, 4635.351050852951], "unit": "score", "name": "dojo.html", "value": 4443.877166716314}, {"lowerIsBetter": false, "replicates": [477.95937345325643, 493.7531234382806, 512.2572270208198, 517.565245194037, 522.3340241192479, 24126.51746965062, 31888.521672174906, 32103.35793284133, 32166.67833321669, 32230.194245143826, 34435.82782086086, 35024.824875875645, 35026.824865875635, 35034.124146896276, 35079.64920350796, 7500.887486687704, 7687.769956806912, 7687.884681729778, 7696.615169241543, 7701.383889288843, 7432.554046757185, 7500.249975002511, 7522.833960736068, 7532.322091011808, 7551.24487551246, 7538.660760265774, 7549.094108706963, 7550.131734850507, 7591.3926885849, 7594.962025189866, 7479.5886226257535, 7503.287187717158, 7520.887186692204, 7703.768886933401, 7731.574763388011, 7648.158702542716, 7728.7681369559, 7803.531788092732, 7806.0, 7822.6088695564995, 36201.0, 36591.4511282331, 36953.630463695554, 37020.0, 37107.814460927526, 2790.5489145644356, 2857.6142220800134, 2992.5511173323957, 3518.469465782393, 3547.308274886398, 27263.182104536896, 27799.722002779916, 27807.721922780715, 28149.718502814914, 28507.0, 3391.525186473871, 3393.592768867727, 3410.4543273076188, 3449.3618680544178, 3532.0993146747414, 210026.0, 210753.0, 211600.0, 213933.0, 214294.0, 48469.0, 51212.487875121515, 51332.0, 51473.22790158151, 51503.484965149866, 42863.571364285955, 55497.167542486895, 56791.14813277804, 56820.0, 56866.715666421405, 13272.601821945356, 13495.325233738275, 13572.728545429234, 13577.932110339385, 13638.727225455634, 10065.949670251603, 10111.393316400892, 10137.746556336004, 10187.337823041478, 10307.072363487172, 16728.749068763977, 16950.23723932426, 17085.57286067858, 17086.145692715316, 17786.46640600784, 7286.854262914712, 7396.149442814038, 7564.659590318449, 7607.695692172362, 7627.694892204249, 854.5342788180457, 893.4951752259952, 939.0843927170954, 1039.1478987230398, 1086.3590481615884, 27697.584536231974, 28167.0, 29453.26366840846, 29457.263568410533, 29470.557941630894, 953.2945620241111, 956.0, 961.711486554045, 1037.0407373179778, 1077.5097330714507, 12368.010559155246, 12477.376131193585, 13540.526081587097, 14171.291435428187, 14438.711225775636, 249534.00931981258, 255022.0, 255299.0, 255723.0, 256445.0, 44588.55411445909, 44817.32774008392, 44857.55142448599, 44861.55138448639, 44868.775656121514, 1236.116176933497, 1241.76406482768, 1247.3326770177912, 1248.182440501473, 1266.9176503527242, 24644.38389040288, 25387.0, 25498.0, 25537.361565961, 25651.230463086136, 37546.0, 38120.42819357656, 38204.0, 38211.42682859815, 38362.80818595889, 241846.0, 244582.0, 245025.0, 245845.0, 246159.0, 26438.471230574894, 28141.623005239504, 28522.286942825765, 28539.714602854536, 28555.42889142164, 32712.182195445304, 32743.508847367786, 32975.0, 33670.49494257637, 33871.15322116967, 27461.0, 28368.858155709913, 28902.710972890844, 30147.547786783656, 31653.20866978344, 30105.849470752506, 30774.230644234074, 30857.382852343275, 31209.53185702171, 31285.0, 31380.372392551566, 31480.84259578779, 31586.842065789522, 31714.0, 31897.202569935936, 26476.338091547866, 27199.72800271972, 27769.0, 27923.860380698778, 27975.0, 22483.662745059166, 22528.774712253322, 22670.886645566665, 22697.546049079258, 22770.43073923165], "unit": "score", "name": "ext.html", "value": 16164.802801417683}, {"lowerIsBetter": false, "replicates": [344.83964956295324, 346.2054584728049, 348.62174540623414, 348.89533140057995, 353.5492247384583, 13712.108712933652, 13899.776035834257, 14917.925410372933, 15140.77288840667, 15563.066216027019, 14569.635759106028, 14694.63263418415, 15184.31670574824, 15206.163660998669, 15255.466058687949, 4392.363107349441, 5067.0, 5092.083424983502, 5096.668716533413, 5107.0, 4834.6374021948495, 4952.455229924705, 5073.543381095701, 5079.4412614612365, 5082.79668813247, 5012.097822391968, 5036.269740887569, 5839.737211825478, 6106.114613381057, 6112.0, 6004.0, 6023.427774361428, 6024.48791852693, 6458.515611329122, 6490.967545162292, 5931.584789064767, 6169.0, 6246.031865060922, 6249.5625306228585, 6255.812325630193, 17923.551911202194, 18091.819081809277, 18648.720269195972, 18874.52813679669, 18948.67359284837, 1723.414039226669, 1814.4919422561704, 1849.2510533234063, 1876.8873867567854, 2049.231538173185, 13159.802602960963, 13322.800157997637, 13516.189028658311, 13646.021326907641, 13765.0, 1836.8163183681525, 1844.3729132095018, 1869.5232715657555, 1884.3028079610494, 1933.574613585009, 57215.427845721424, 57236.42763572353, 57896.594756651204, 58367.70816145977, 58679.0, 14313.28433578317, 14684.0, 14707.779383309258, 14809.555713328617, 14913.627159321104, 21552.892235538722, 21559.46101347479, 21757.782422175576, 21851.562968740534, 21867.343979680318, 8206.671733130608, 8347.081820999685, 8369.204925532065, 8419.536925469158, 8485.490870547786, 6791.4906382021545, 6819.045333653293, 6822.181338239443, 6829.829254268683, 6834.521583489108, 7315.30504602062, 7380.261973802684, 7404.518706284074, 7404.851902961911, 7484.513506622052, 2934.7358737713707, 2995.1164406500134, 3029.803062800911, 3082.784205105621, 3145.386649603351, 775.2751177648917, 808.720991258015, 874.6239117179547, 956.1155930764015, 986.5807032011367, 14264.714705705828, 15074.924625376803, 15517.379304827906, 15878.206089695468, 16410.261538230807, 765.8506591214771, 778.2412148155616, 793.6190628498238, 821.5604651511412, 834.1283358889974, 8258.463199891989, 8285.088640249567, 8386.371022173362, 8454.704085357105, 8458.8477059107, 433453.0, 434417.0, 436034.0, 438348.0, 443625.0, 61249.693751530955, 62558.0, 62802.37197628056, 63367.68316158482, 63439.36560634427, 1013.5742987945081, 1044.368157264859, 1045.2160879340342, 1054.1303424674675, 1100.5047728522036, 13486.0, 13616.114952528054, 13622.93188534051, 13690.794638080237, 14031.228282444563, 26996.865015674797, 27004.05485807987, 27167.184984450498, 27474.862625686743, 27878.58182127229, 35022.64977350194, 36189.27621447609, 40116.59883401129, 40385.1922961545, 40811.79594102011, 6208.317085120723, 6435.388638079375, 6526.24948130971, 6633.436157926631, 6724.394804467622, 7601.619919004138, 8060.959695201486, 10253.33353332031, 10266.230032747424, 10326.380417174994, 7765.961170194113, 8581.798548203382, 8610.870836937325, 8644.740657780276, 8968.865467018131, 8672.132786721277, 9056.366054376394, 9329.58016889228, 9472.100150485692, 9527.0, 8974.461532308082, 9065.909340906506, 9267.76830579241, 9361.906380936103, 9768.902310976799, 6501.772437964649, 6605.438537724347, 6620.205575330991, 6647.102641143577, 6698.196216454056, 8248.958755206186, 8263.173682631688, 8872.64509419616, 8879.334049946408, 9008.684696035607], "unit": "score", "name": "jquery.html", "value": 8203.646265120424}, {"lowerIsBetter": false, "replicates": [1370.5477192526466, 1380.7790753479442, 1489.9553013409602, 1682.1925475771623, 1694.0851939952418, 6834.555753876, 6921.515493915428, 7012.053372794671, 7080.3273688999525, 7112.324329188726, 7094.822629434267, 7122.8575428491395, 7185.2814718528125, 7200.639968001605, 7239.348458638721, 2020.151536354731, 2066.1735305877696, 2066.6693329067352, 2067.069818581637, 2071.0680193912726, 2062.257587268582, 2074.9273775417864, 2085.8331333493284, 2093.7592176899625, 2094.2670065477037, 2018.7072874433272, 2070.3788863340937, 2072.616565935299, 2073.0360382422173, 2093.518490747129, 2035.297822251321, 2055.0033233881554, 2059.567490826928, 2063.0509965416004, 2066.4937090412795, 2008.0762849089435, 2034.8473864460077, 2037.5822956294073, 2040.4898775306174, 2042.234162189179, 6869.690863911136, 6939.340762627542, 6958.234594194634, 6958.47811414146, 6962.477814163907, 4105.7331273467125, 4206.032612499112, 4234.491860976672, 4236.04688944988, 4259.1268789897995, 2647.9867600662064, 2650.0989663514497, 2700.230434326227, 2701.9054333098247, 2703.4863375958503, 812.2446125103651, 823.2919689067397, 839.5382539603255, 858.4463021351194, 868.9695860644847, 9382.906170938271, 9584.66453674118, 9594.9520252399, 9682.46746428946, 9690.224782017422, 3754.3617585010616, 3817.7900215488417, 3856.82644281008, 3860.208657225262, 3930.0371409004406, 8410.285125764256, 8421.073681894986, 8447.45091569046, 8449.070602233749, 8476.364272679573, 4172.561881002512, 4174.582541745801, 4180.832766689298, 4193.22425351311, 4220.177065472203, 3746.83139258734, 3763.7553559018575, 3791.962080379216, 3793.317202903504, 3800.600936901641, 3347.246869454353, 3349.815760133216, 3365.6297807241185, 3370.8651653934057, 3420.9144771380415, 1037.6990672704983, 1076.8007918535095, 1077.757504561483, 1078.3907092492716, 1078.6440474643348, 849.6601359456267, 871.4205053639386, 887.6538150121457, 920.4937284493502, 952.9184375733593, 6527.477801775942, 6598.076269322299, 6627.834304142435, 6635.336466353423, 6645.767398141042, 1020.806046851096, 1040.8386700061503, 1041.5365162502615, 1050.9054185123375, 1059.422614675004, 4965.453800081988, 4986.501349864984, 4999.075171093359, 4999.800007999712, 5024.020316038411, 8298.087210406851, 8471.279941204943, 8540.701075462453, 8602.956985215034, 8837.337199710048, 8697.130286971253, 8706.6517339307, 8734.213920747163, 8755.693550725695, 8805.867911981326, 6786.3892249697765, 6814.8637027260165, 6853.560752241985, 6969.895451568231, 6994.195667498201, 6426.678666066585, 6470.22357317125, 6474.773382931575, 6477.578957367756, 6511.804645860631, 7685.5004424712215, 7771.844563108819, 7836.177201394, 7840.490368126054, 7929.643166057426, 7887.605619718876, 7945.205479452008, 8004.679812807422, 8146.9185308148535, 8172.5913704315735, 6079.939200608114, 6169.444749972524, 6170.938290617037, 6208.161898143873, 6223.439890409885, 6268.968655156695, 6419.743210271724, 6421.678916054085, 6426.550141490051, 6536.803895883131, 6178.443940045418, 6185.443310102112, 6274.843128921813, 6356.841078972878, 6442.452391546583, 5601.011640867433, 6099.024156135175, 6137.048757442603, 6153.230846144232, 6227.844303892439, 6365.872682546231, 6369.172007638977, 6376.808695739135, 6388.36116388376, 6400.615963042233, 5990.7304171311525, 6052.243469566304, 6056.06131049688, 6058.848528786815, 6111.908321375094, 5670.716464176692, 5768.336641286306, 5801.3908539602735, 5806.535477161732, 5820.097884827858], "unit": "score", "name": "mootools.html", "value": 4046.4106552347603}, {"lowerIsBetter": false, "replicates": [307.5248740695625, 312.0342539839197, 312.7482376686766, 314.3367494586422, 326.5542534440488, 5461.262729531512, 5490.094134467818, 5588.6646801191855, 5618.157276408536, 5623.831285061445, 5378.515933565978, 5421.647592906458, 5439.755211015504, 5458.781648734046, 5476.534494567966, 4074.7962601869935, 4085.1829634073156, 4095.1604920991126, 4185.958140418587, 4186.644135248507, 4150.792460376984, 4154.43915071466, 4154.97922510387, 4158.168366326731, 4165.937510937339, 4168.395582640515, 4181.121964387482, 4191.622753952143, 4191.790410479479, 4197.349410841309, 4186.995121170928, 4192.182524407742, 4200.138971510848, 4228.746275223466, 4229.048464095585, 3526.7883926964464, 3609.9639003610155, 3642.1258897864586, 3654.7076233901225, 3656.542932133483, 5158.53573178412, 5287.365516138049, 5304.761285742151, 5322.0952438085615, 5322.840314790563, 4877.707337559757, 4882.145624515695, 4885.462599114095, 4894.192458244385, 4895.902081958377, 5779.248697669318, 5806.5645076619, 5819.912701309484, 5826.82519524415, 5838.766449342022, 3934.7639141651307, 4020.839166433339, 4024.1146947671464, 4031.133306339151, 4035.3745169498775, 6016.1878146450545, 6021.939780602182, 6057.787977420813, 6081.27024757032, 6089.543284253655, 4120.814563344657, 4122.319817230184, 4131.442255295557, 4143.482064741907, 4146.067134894624, 4205.411242426063, 4215.283401821697, 4222.641075508554, 4223.387608796707, 4230.957690423118, 4572.95427045732, 4643.558861908114, 4828.903421931542, 4830.227163653799, 4844.515548445127, 5719.0, 5756.0, 5769.711514424262, 5779.537636989031, 5792.7103644818435, 1422.4665750343622, 1436.6911114110308, 1437.1664434628099, 1439.3954539093397, 1440.3950340856866, 964.7250533597891, 992.8659630949729, 1002.9849552256723, 1012.1346248957183, 1026.9229807764298, 5074.974625126851, 5105.0, 5105.744712764347, 5120.436751957282, 5128.948710512847, 6004.909926351108, 6027.57806953509, 6036.879262414727, 6042.791441711675, 6044.697765111727, 5065.797368105234, 5072.923906141411, 5084.110280700863, 5119.718415487184, 5130.948690513047, 3153.385089907446, 3231.9030429087165, 3250.5286733423995, 3255.7395408367274, 3270.9509357359657, 5634.154876768517, 5641.323041235078, 5654.15187721845, 5686.0333743263745, 5695.117256825199, 6194.81415557534, 6198.752049918043, 6202.72087756052, 6211.254649442096, 6211.720472578745, 5513.641613295123, 5626.2967129108865, 5646.322441307069, 5678.659280443187, 5682.488576028178, 5969.492593129633, 5986.610870293417, 6003.969980150071, 6004.369541198112, 6013.789517366871, 5888.381719919518, 5903.350631430625, 5903.616264942765, 5903.763849446146, 5916.852078698067, 5646.181303711021, 5665.575081868794, 5674.773009079756, 5678.74445649955, 5683.3748287687495, 3885.747426417274, 3993.520777506718, 3997.140614767839, 4005.1388951375593, 4025.2352053109817, 5923.763049477972, 5955.702214889152, 6000.669963152069, 6007.137787285956, 6020.458158765732, 5812.651240925558, 5820.621659592113, 5823.505002074701, 5838.883222335445, 5842.269716285465, 5825.70871456434, 5832.387599302012, 5837.970810145922, 5838.503727183237, 5839.299284085767, 5609.74756135983, 5672.0, 5694.971525142348, 5707.258056452634, 5707.942920570741, 5861.179434879035, 5869.413058694267, 5876.911846322394, 5880.50015748649, 5897.41025897424, 5662.207290979184, 5686.459786320293, 5690.118031705092, 5692.971535142464, 5700.629459085146], "unit": "score", "name": "prototype.html", "value": 4327.502278510409}, {"lowerIsBetter": false, "replicates": [755.2296657409443, 761.177927837935, 764.4037650632505, 773.8955241042461, 787.1498781316179, 11096.667099987004, 11254.49354779035, 11274.549018039268, 11275.492602832872, 11298.661040168787, 11954.940225298884, 11976.820347694791, 12041.0, 12051.879481205186, 12058.155929084967, 758.5183408535564, 763.6105586151075, 781.7263957614846, 783.4476693930793, 785.2814674572759, 778.7469072551444, 779.4232268121577, 779.6062988190955, 780.8204113054001, 782.4679218131669, 815.7715839564931, 817.5585184000662, 817.5912043978011, 817.9631916563769, 820.327331588098, 805.1385018030738, 806.72168102005, 808.7533302342783, 809.4455298120777, 811.2293321344687, 597.175897261776, 601.3685630088434, 601.4616917858535, 603.1314906534576, 604.4137186928672, 11803.11476639247, 11887.40562971848, 11920.642380728592, 11924.105692073043, 11938.104642151786, 11419.371934543597, 11696.532138714527, 11767.764644707058, 11783.823242651368, 12263.386830658432, 9517.191038761714, 9634.373765705206, 9779.413235205839, 9805.705828825146, 9809.705708828747, 3095.5666206731075, 3137.262743255333, 3142.151619062863, 3186.4105140549073, 3226.0160651001434, 41646.37530437076, 42063.7896810514, 42092.0, 42193.0, 42245.57754422447, 9110.274940771253, 9128.58921348541, 9167.770805729777, 9218.287989777275, 9348.1119293667, 15992.0, 16021.759673604905, 16031.278592463366, 16034.919825400799, 16049.037057776572, 6277.340879207617, 6617.205935287796, 6670.39966403026, 6725.529212955144, 6845.418139458102, 3540.2565461253425, 3559.7864128152396, 3612.2233719749856, 3640.2355505344176, 3671.4125739882024, 2513.710923243814, 2523.041244327144, 2533.2020413569667, 2538.4796116796015, 2545.503626792795, 484.6244160775427, 485.3084354794404, 491.67303743010496, 495.4995454590889, 499.2261993909426, 431.29698591296614, 529.1797713543991, 558.0732619580085, 577.7804434314934, 586.6919867069737, 7418.740344088039, 7561.924380756122, 7571.962140189264, 7581.166071732105, 7617.466777325645, 459.9287110497878, 506.05115408608856, 568.3605943313772, 574.5690731951037, 647.934148326001, 3665.725070619714, 3678.2459595782802, 3748.981255093762, 3756.530433695788, 3759.1353988582778, 46357.768211159404, 46396.30405543919, 46854.0, 47090.764546177736, 48256.758716206896, 40407.39388909169, 40713.38929916054, 40914.38628420517, 40982.385264220466, 45771.542284577394, 39396.212075758325, 41344.1731165375, 41540.58459415428, 42282.36576451355, 42369.788151059045, 7707.691692332244, 7975.4018448615425, 7980.12218655959, 8162.10216876155, 8274.462159959825, 29473.410531789672, 30150.0, 30584.84707576448, 30644.84677576598, 30696.07911762651, 34913.65086349104, 35380.823095884356, 36936.81531592432, 37119.628803712694, 37584.62415375921, 10273.86987431367, 10275.126614237874, 10351.120154786928, 10451.68644940653, 10549.156067514734, 11368.147388946027, 11377.886221138015, 11379.54481820751, 11425.31448113116, 11532.769344612892, 10435.16518678519, 10712.678619641423, 10718.088962437969, 10727.195460340661, 10969.670909872397, 10915.508802103766, 10940.0, 11016.889831101586, 11042.613508527484, 11331.773364532499, 10344.53449594755, 11159.27464714791, 11176.944115279372, 11188.0, 11191.832122518332, 9064.773380665272, 9171.40385874916, 9267.351285409957, 9273.443593384418, 9604.567794449405, 8245.95877020611, 8680.175383338572, 8730.65077396897, 9405.670801521914, 9418.481983490974], "unit": "score", "name": "yui.html", "value": 5688.913545816775}], "name": "dromaeo_css", "value": 6234.284133805762}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [119.0, 112.0, 118.0, 118.0, 117.0, 129.0, 114.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 117.1}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 160.0, 168.0, 138.0, 161.0, 160.0, 131.0, 168.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 166.0, 166.0, 164.0, 161.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 74.0, 136.0, 75.0, 72.0, 74.0, 73.0, 89.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 141.0, 97.0, 98.0, 97.0, 140.0, 99.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 103.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 73.0, 75.0, 73.0, 72.0, 72.0, 73.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 71.0, 67.0, 72.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 88.0, 86.0, 85.0, 86.0, 84.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 125.0, 130.0, 123.0, 124.0, 124.0, 138.0, 122.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [143.0, 167.0, 158.0, 152.0, 153.0, 141.0, 158.0, 159.0, 157.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [71.0, 77.0, 75.0, 73.0, 73.0, 72.0, 72.0, 72.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1557.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.9986320109439], "unit": "score", "name": "Richards", "value": 206.4460960000001}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [729.3946024799417], "unit": "score", "name": "Earley", "value": 913.7207730000002}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [43340.425531914894], "unit": "score", "name": "RegExp", "value": 21.019290623465874}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20082.097359687767}]} 19:20:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20082.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1557.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6234.28"}}} 19:20:14 INFO - Return code: 0 19:20:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:14 INFO - # TBPL SUCCESS # 19:20:14 INFO - Running post-action listener: _resource_record_post_action 19:20:14 INFO - Running post-run listener: _resource_record_post_run 19:20:15 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539967488; Read time: 52; Write time: 495736 19:20:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231206912; Read time: 0; Write time: 265220 19:20:15 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308756480; Read time: 52; Write time: 230488 19:20:15 INFO - Running post-run listener: _upload_blobber_files 19:20:15 INFO - Blob upload gear active. 19:20:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:15 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 19:20:15 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'] 19:20:15 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 19:20:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:16 INFO - (blobuploader) - INFO - Done attempting. 19:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:17 INFO - (blobuploader) - INFO - Done attempting. 19:20:17 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:17 INFO - Return code: 0 19:20:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a281bb1d44b2bfc7a25dabebbbe7f1ee8f03b869fbfedf69a433ff81ca1e156ed1a772aeb2069339e06a9f1fc64bc8023387a4ebb245e44ad5a1cd71632fc5a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff97262135a64a16ff6a70d5be7d381fb4461e7ae98693e6b3d54dd0a60b8a6c67d6d44a9b4c41e33c726f5d33142d2dc5f48d8a4db954110b6507acb915d7ae"} 19:20:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:17 INFO - Contents: 19:20:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a281bb1d44b2bfc7a25dabebbbe7f1ee8f03b869fbfedf69a433ff81ca1e156ed1a772aeb2069339e06a9f1fc64bc8023387a4ebb245e44ad5a1cd71632fc5a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff97262135a64a16ff6a70d5be7d381fb4461e7ae98693e6b3d54dd0a60b8a6c67d6d44a9b4c41e33c726f5d33142d2dc5f48d8a4db954110b6507acb915d7ae"} 19:20:17 INFO - Copying logs to upload dir... 19:20:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.867546 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 19:20:16.988075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:20:16.991976) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a281bb1d44b2bfc7a25dabebbbe7f1ee8f03b869fbfedf69a433ff81ca1e156ed1a772aeb2069339e06a9f1fc64bc8023387a4ebb245e44ad5a1cd71632fc5a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff97262135a64a16ff6a70d5be7d381fb4461e7ae98693e6b3d54dd0a60b8a6c67d6d44a9b4c41e33c726f5d33142d2dc5f48d8a4db954110b6507acb915d7ae"} build_url:https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/Nn4PuvW5TZ6d_dueoeaT5g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a281bb1d44b2bfc7a25dabebbbe7f1ee8f03b869fbfedf69a433ff81ca1e156ed1a772aeb2069339e06a9f1fc64bc8023387a4ebb245e44ad5a1cd71632fc5a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff97262135a64a16ff6a70d5be7d381fb4461e7ae98693e6b3d54dd0a60b8a6c67d6d44a9b4c41e33c726f5d33142d2dc5f48d8a4db954110b6507acb915d7ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:20:17.017234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:20:17.017649) ========= 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=d2a8c569965ab8367867b893000001a1-1452740336.401001-671196808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:20:17.105360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:20:17.106169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:20:17.106884) ========= ========= Total master_lag: 1.47 =========