builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1452514769.78 results: success (0) buildid: 20160111030532 builduid: 3f5840c3bbab4f0a8b370a60307ffefb revision: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.781125) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.781575) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.781909) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006206 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.833183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.833505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.857534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.857827) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004745 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.911862) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.912157) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.912574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:29.912950) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 04:19:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-11 04:19:30 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.094549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.094858) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.144454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.144820) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60a85952d9fdbd2740d6764aaf172735a37e1ca7 --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 60a85952d9fdbd2740d6764aaf172735a37e1ca7 --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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 04:19:30,902 truncating revision to first 12 chars 2016-01-11 04:19:30,902 Setting DEBUG logging. 2016-01-11 04:19:30,902 attempt 1/10 2016-01-11 04:19:30,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60a85952d9fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 04:19:31,193 unpacking tar archive at: mozilla-central-60a85952d9fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.763667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.763983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.778045) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.778309) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:19:30.778731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-11 04:19:30.779041) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:31 INFO - MultiFileLogger online at 20160111 04:19:31 in /builds/slave/test 04:19:31 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 04:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:31 INFO - {'append_to_log': False, 04:19:31 INFO - 'base_work_dir': '/builds/slave/test', 04:19:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:31 INFO - 'branch': 'Firefox-Non-PGO', 04:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:31 INFO - 'config_files': ('talos/linux_config.py',), 04:19:31 INFO - 'default_actions': ('clobber', 04:19:31 INFO - 'read-buildbot-config', 04:19:31 INFO - 'download-and-extract', 04:19:31 INFO - 'populate-webroot', 04:19:31 INFO - 'create-virtualenv', 04:19:31 INFO - 'install', 04:19:31 INFO - 'run-tests'), 04:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:31 INFO - 'download_minidump_stackwalk': True, 04:19:31 INFO - 'download_symbols': 'ondemand', 04:19:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:31 INFO - 'installer_path': 'installer.exe', 04:19:31 INFO - 'log_level': 'info', 04:19:31 INFO - 'log_name': 'talos', 04:19:31 INFO - 'log_to_console': True, 04:19:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:31 INFO - 'opt_config_files': (), 04:19:31 INFO - 'pip_index': False, 04:19:31 INFO - 'sps_profile': False, 04:19:31 INFO - 'sps_profile_interval': 0, 04:19:31 INFO - 'suite': 'dromaeojs-e10s', 04:19:31 INFO - 'system_bits': '32', 04:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:31 INFO - 'title': 'talos-linux64-ix-057', 04:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:31 INFO - 'use_talos_json': True, 04:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:31 INFO - 'work_dir': 'build'} 04:19:31 INFO - ##### 04:19:31 INFO - ##### Running clobber step. 04:19:31 INFO - ##### 04:19:31 INFO - Running pre-action listener: _resource_record_pre_action 04:19:31 INFO - Running main action method: clobber 04:19:31 INFO - rmtree: /builds/slave/test/build 04:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:32 INFO - Running post-action listener: _resource_record_post_action 04:19:32 INFO - ##### 04:19:32 INFO - ##### Running read-buildbot-config step. 04:19:32 INFO - ##### 04:19:32 INFO - Running pre-action listener: _resource_record_pre_action 04:19:32 INFO - Running main action method: read_buildbot_config 04:19:32 INFO - Using buildbot properties: 04:19:32 INFO - { 04:19:32 INFO - "project": "", 04:19:32 INFO - "product": "firefox", 04:19:32 INFO - "script_repo_revision": "production", 04:19:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:19:32 INFO - "repository": "", 04:19:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:19:32 INFO - "buildid": "20160111030532", 04:19:32 INFO - "pgo_build": "False", 04:19:32 INFO - "basedir": "/builds/slave/test", 04:19:32 INFO - "buildnumber": 150, 04:19:32 INFO - "slavename": "talos-linux64-ix-057", 04:19:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:19:32 INFO - "platform": "ubuntu64_hw", 04:19:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:19:32 INFO - "branch": "mozilla-central", 04:19:32 INFO - "repo_path": "mozilla-central", 04:19:32 INFO - "revision": "60a85952d9fdbd2740d6764aaf172735a37e1ca7", 04:19:32 INFO - "stage_platform": "linux64", 04:19:32 INFO - "builduid": "3f5840c3bbab4f0a8b370a60307ffefb", 04:19:32 INFO - "slavebuilddir": "test" 04:19:32 INFO - } 04:19:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:19:32 INFO - Running post-action listener: _resource_record_post_action 04:19:32 INFO - ##### 04:19:32 INFO - ##### Running download-and-extract step. 04:19:32 INFO - ##### 04:19:32 INFO - Running pre-action listener: _resource_record_pre_action 04:19:32 INFO - Running main action method: download_and_extract 04:19:32 INFO - mkdir: /builds/slave/test/build/tests 04:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:32 INFO - https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/test_packages.json 04:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/test_packages.json 04:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:19:43 INFO - Downloaded 1302 bytes. 04:19:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:19:43 INFO - Using the following test package requirements: 04:19:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'jsshell-linux-x86_64.zip'], 04:19:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:43 INFO - https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:19:47 INFO - Downloaded 22761282 bytes. 04:19:47 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 04:19:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:47 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 04:19:48 INFO - Return code: 0 04:19:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:48 INFO - https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:19:50 INFO - Downloaded 22761282 bytes. 04:19:50 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 04:19:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:19:50 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 04:19:52 INFO - Return code: 0 04:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:52 INFO - https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:19:54 INFO - Downloaded 11132285 bytes. 04:19:54 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 04:19:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:54 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 04:19:54 INFO - Return code: 0 04:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:54 INFO - https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:19:59 INFO - Downloaded 54050975 bytes. 04:19:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:59 INFO - mkdir: /builds/slave/test/properties 04:19:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:59 INFO - Contents: 04:19:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:19:59 INFO - Running post-action listener: _resource_record_post_action 04:19:59 INFO - Running post-action listener: set_extra_try_arguments 04:19:59 INFO - ##### 04:19:59 INFO - ##### Running populate-webroot step. 04:19:59 INFO - ##### 04:19:59 INFO - Running pre-action listener: _resource_record_pre_action 04:19:59 INFO - Running main action method: populate_webroot 04:19:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:59 INFO - '--tppagecycles', 04:19:59 INFO - '7'], 04:19:59 INFO - 'tests': ['tsvgm']}}, 04:19:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:19:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'tests': ['damp', 'tps']}, 04:19:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['damp', 'tps']}, 04:19:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:19:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:59 INFO - 'other': {'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'other_l64': {'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'other_nol64': {'tests': ['a11yr', 04:19:59 INFO - 'ts_paint', 04:19:59 INFO - 'tpaint', 04:19:59 INFO - 'sessionrestore', 04:19:59 INFO - 'sessionrestore_no_auto_restore']}, 04:19:59 INFO - 'svgr': {'tests': ['tsvgx', 04:19:59 INFO - 'tsvgr_opacity', 04:19:59 INFO - 'tart', 04:19:59 INFO - 'tscrollx', 04:19:59 INFO - 'cart']}, 04:19:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['tsvgx', 04:19:59 INFO - 'tsvgr_opacity', 04:19:59 INFO - 'tart', 04:19:59 INFO - 'tscrollx', 04:19:59 INFO - 'cart']}, 04:19:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'tests': ['tp5o']}, 04:19:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'talos_options': ['--e10s'], 04:19:59 INFO - 'tests': ['tp5o']}, 04:19:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'talos_options': ['--xperf_path', 04:19:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:59 INFO - 'tests': ['tp5n']}, 04:19:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:59 INFO - 'talos_options': ['--e10s', 04:19:59 INFO - '--xperf_path', 04:19:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:59 INFO - 'tests': ['tp5n']}}, 04:19:59 INFO - 'talos.zip': {'path': '', 04:19:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:59 INFO - Running post-action listener: _resource_record_post_action 04:19:59 INFO - ##### 04:19:59 INFO - ##### Running create-virtualenv step. 04:19:59 INFO - ##### 04:19:59 INFO - Running pre-action listener: _resource_record_pre_action 04:19:59 INFO - Running main action method: create_virtualenv 04:19:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:19:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:59 INFO - Using real prefix '/usr' 04:19:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:01 INFO - Installing pip.................done. 04:20:01 INFO - Return code: 0 04:20:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:01 INFO - Using env: {'DISPLAY': ':0', 04:20:01 INFO - 'HOME': '/home/cltbld', 04:20:01 INFO - 'LANG': 'en_US.UTF-8', 04:20:01 INFO - 'LANGUAGE': 'en_US:en', 04:20:01 INFO - 'LOGNAME': 'cltbld', 04:20:01 INFO - 'MAIL': '/var/mail/cltbld', 04:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:01 INFO - 'MOZ_NO_REMOTE': '1', 04:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:01 INFO - 'NO_EM_RESTART': '1', 04:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:01 INFO - 'PWD': '/builds/slave/test', 04:20:01 INFO - 'SHELL': '/bin/bash', 04:20:01 INFO - 'SHLVL': '1', 04:20:01 INFO - 'TERM': 'linux', 04:20:01 INFO - 'TMOUT': '86400', 04:20:01 INFO - 'USER': 'cltbld', 04:20:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:01 INFO - '_': '/tools/buildbot/bin/python'} 04:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:20:02 INFO - Cleaning up... 04:20:02 INFO - Return code: 0 04:20:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:20:02 INFO - Using env: {'DISPLAY': ':0', 04:20:02 INFO - 'HOME': '/home/cltbld', 04:20:02 INFO - 'LANG': 'en_US.UTF-8', 04:20:02 INFO - 'LANGUAGE': 'en_US:en', 04:20:02 INFO - 'LOGNAME': 'cltbld', 04:20:02 INFO - 'MAIL': '/var/mail/cltbld', 04:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:02 INFO - 'MOZ_NO_REMOTE': '1', 04:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:02 INFO - 'NO_EM_RESTART': '1', 04:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:02 INFO - 'PWD': '/builds/slave/test', 04:20:02 INFO - 'SHELL': '/bin/bash', 04:20:02 INFO - 'SHLVL': '1', 04:20:02 INFO - 'TERM': 'linux', 04:20:02 INFO - 'TMOUT': '86400', 04:20:02 INFO - 'USER': 'cltbld', 04:20:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:02 INFO - '_': '/tools/buildbot/bin/python'} 04:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:02 INFO - Downloading/unpacking psutil>=0.7.1 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:20:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:04 INFO - Installing collected packages: psutil 04:20:04 INFO - Running setup.py install for psutil 04:20:04 INFO - building 'psutil._psutil_linux' extension 04:20:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:20:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:04 INFO - building 'psutil._psutil_posix' extension 04:20:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:04 INFO - Successfully installed psutil 04:20:04 INFO - Cleaning up... 04:20:04 INFO - Return code: 0 04:20:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:04 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:20:04 INFO - Using env: {'DISPLAY': ':0', 04:20:04 INFO - 'HOME': '/home/cltbld', 04:20:04 INFO - 'LANG': 'en_US.UTF-8', 04:20:04 INFO - 'LANGUAGE': 'en_US:en', 04:20:04 INFO - 'LOGNAME': 'cltbld', 04:20:04 INFO - 'MAIL': '/var/mail/cltbld', 04:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:04 INFO - 'MOZ_NO_REMOTE': '1', 04:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:04 INFO - 'NO_EM_RESTART': '1', 04:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:04 INFO - 'PWD': '/builds/slave/test', 04:20:04 INFO - 'SHELL': '/bin/bash', 04:20:04 INFO - 'SHLVL': '1', 04:20:04 INFO - 'TERM': 'linux', 04:20:04 INFO - 'TMOUT': '86400', 04:20:04 INFO - 'USER': 'cltbld', 04:20:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:04 INFO - '_': '/tools/buildbot/bin/python'} 04:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:20:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:20:06 INFO - Installing collected packages: mozsystemmonitor 04:20:06 INFO - Running setup.py install for mozsystemmonitor 04:20:06 INFO - Successfully installed mozsystemmonitor 04:20:06 INFO - Cleaning up... 04:20:06 INFO - Return code: 0 04:20:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:06 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:20:06 INFO - Using env: {'DISPLAY': ':0', 04:20:06 INFO - 'HOME': '/home/cltbld', 04:20:06 INFO - 'LANG': 'en_US.UTF-8', 04:20:06 INFO - 'LANGUAGE': 'en_US:en', 04:20:06 INFO - 'LOGNAME': 'cltbld', 04:20:06 INFO - 'MAIL': '/var/mail/cltbld', 04:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:06 INFO - 'MOZ_NO_REMOTE': '1', 04:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:06 INFO - 'NO_EM_RESTART': '1', 04:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:06 INFO - 'PWD': '/builds/slave/test', 04:20:06 INFO - 'SHELL': '/bin/bash', 04:20:06 INFO - 'SHLVL': '1', 04:20:06 INFO - 'TERM': 'linux', 04:20:06 INFO - 'TMOUT': '86400', 04:20:06 INFO - 'USER': 'cltbld', 04:20:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:06 INFO - '_': '/tools/buildbot/bin/python'} 04:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:09 INFO - Downloading docopt-0.6.1.tar.gz 04:20:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:09 INFO - Running setup.py install for blobuploader 04:20:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:09 INFO - Running setup.py install for requests 04:20:09 INFO - Running setup.py install for docopt 04:20:10 INFO - Successfully installed blobuploader requests docopt 04:20:10 INFO - Cleaning up... 04:20:10 INFO - Return code: 0 04:20:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:10 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:10 INFO - Using env: {'DISPLAY': ':0', 04:20:10 INFO - 'HOME': '/home/cltbld', 04:20:10 INFO - 'LANG': 'en_US.UTF-8', 04:20:10 INFO - 'LANGUAGE': 'en_US:en', 04:20:10 INFO - 'LOGNAME': 'cltbld', 04:20:10 INFO - 'MAIL': '/var/mail/cltbld', 04:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:10 INFO - 'MOZ_NO_REMOTE': '1', 04:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:10 INFO - 'NO_EM_RESTART': '1', 04:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:10 INFO - 'PWD': '/builds/slave/test', 04:20:10 INFO - 'SHELL': '/bin/bash', 04:20:10 INFO - 'SHLVL': '1', 04:20:10 INFO - 'TERM': 'linux', 04:20:10 INFO - 'TMOUT': '86400', 04:20:10 INFO - 'USER': 'cltbld', 04:20:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:10 INFO - '_': '/tools/buildbot/bin/python'} 04:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:10 INFO - Running setup.py (path:/tmp/pip-aw_jVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:10 INFO - Running setup.py (path:/tmp/pip-CdRrlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:10 INFO - Running setup.py (path:/tmp/pip-rSUJ_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:10 INFO - Running setup.py (path:/tmp/pip-bP5Vcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:10 INFO - Running setup.py (path:/tmp/pip-eazzg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:10 INFO - Running setup.py (path:/tmp/pip-GZLRBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:10 INFO - Running setup.py (path:/tmp/pip-RlvERr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:10 INFO - Running setup.py (path:/tmp/pip-POp_Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:10 INFO - Running setup.py (path:/tmp/pip-1QZCZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:10 INFO - Running setup.py (path:/tmp/pip-x9dxc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:11 INFO - Running setup.py (path:/tmp/pip-MobcBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:11 INFO - Running setup.py (path:/tmp/pip-y71F0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:11 INFO - Running setup.py (path:/tmp/pip-QK4USp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:11 INFO - Running setup.py (path:/tmp/pip-Gl4LH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:11 INFO - Running setup.py (path:/tmp/pip-EAIRwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:11 INFO - Running setup.py (path:/tmp/pip-m8b8DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:11 INFO - Running setup.py (path:/tmp/pip-9g78g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:11 INFO - Running setup.py install for manifestparser 04:20:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Running setup.py install for mozcrash 04:20:11 INFO - Running setup.py install for mozdebug 04:20:11 INFO - Running setup.py install for mozdevice 04:20:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Running setup.py install for mozfile 04:20:12 INFO - Running setup.py install for mozhttpd 04:20:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for mozinfo 04:20:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for mozInstall 04:20:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for mozleak 04:20:12 INFO - Running setup.py install for mozlog 04:20:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for moznetwork 04:20:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for mozprocess 04:20:12 INFO - Running setup.py install for mozprofile 04:20:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:12 INFO - Running setup.py install for mozrunner 04:20:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:13 INFO - Running setup.py install for mozscreenshot 04:20:13 INFO - Running setup.py install for moztest 04:20:13 INFO - Running setup.py install for mozversion 04:20:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:13 INFO - Cleaning up... 04:20:13 INFO - Return code: 0 04:20:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:13 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:13 INFO - Using env: {'DISPLAY': ':0', 04:20:13 INFO - 'HOME': '/home/cltbld', 04:20:13 INFO - 'LANG': 'en_US.UTF-8', 04:20:13 INFO - 'LANGUAGE': 'en_US:en', 04:20:13 INFO - 'LOGNAME': 'cltbld', 04:20:13 INFO - 'MAIL': '/var/mail/cltbld', 04:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:13 INFO - 'MOZ_NO_REMOTE': '1', 04:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:13 INFO - 'NO_EM_RESTART': '1', 04:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:13 INFO - 'PWD': '/builds/slave/test', 04:20:13 INFO - 'SHELL': '/bin/bash', 04:20:13 INFO - 'SHLVL': '1', 04:20:13 INFO - 'TERM': 'linux', 04:20:13 INFO - 'TMOUT': '86400', 04:20:13 INFO - 'USER': 'cltbld', 04:20:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:13 INFO - '_': '/tools/buildbot/bin/python'} 04:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:13 INFO - Running setup.py (path:/tmp/pip-utYdj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:13 INFO - Running setup.py (path:/tmp/pip-WqIXbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:13 INFO - Running setup.py (path:/tmp/pip-9wRuQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:13 INFO - Running setup.py (path:/tmp/pip-rw1uos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:13 INFO - Running setup.py (path:/tmp/pip-EMlYdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:13 INFO - Running setup.py (path:/tmp/pip-evnRWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:13 INFO - Running setup.py (path:/tmp/pip-CHUQTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:14 INFO - Running setup.py (path:/tmp/pip-idDOLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:14 INFO - Running setup.py (path:/tmp/pip-agLDNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:14 INFO - Running setup.py (path:/tmp/pip-rwMjgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:14 INFO - Running setup.py (path:/tmp/pip-2E4PND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:14 INFO - Running setup.py (path:/tmp/pip-Qojxt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:14 INFO - Running setup.py (path:/tmp/pip-lu0cNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:14 INFO - Running setup.py (path:/tmp/pip-bvjpwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:14 INFO - Running setup.py (path:/tmp/pip-buMCum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:14 INFO - Running setup.py (path:/tmp/pip-uObudP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:14 INFO - Running setup.py (path:/tmp/pip-AUHizV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:16 INFO - Downloading blessings-1.5.1.tar.gz 04:20:16 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:16 INFO - Installing collected packages: blessings 04:20:16 INFO - Running setup.py install for blessings 04:20:16 INFO - Successfully installed blessings 04:20:16 INFO - Cleaning up... 04:20:16 INFO - Return code: 0 04:20:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:16 INFO - Reading from file tmpfile_stdout 04:20:16 INFO - Current package versions: 04:20:16 INFO - argparse == 1.2.1 04:20:16 INFO - blessings == 1.5.1 04:20:16 INFO - blobuploader == 1.2.4 04:20:16 INFO - docopt == 0.6.1 04:20:16 INFO - manifestparser == 1.1 04:20:16 INFO - mozInstall == 1.12 04:20:16 INFO - mozcrash == 0.16 04:20:16 INFO - mozdebug == 0.1 04:20:16 INFO - mozdevice == 0.47 04:20:16 INFO - mozfile == 1.2 04:20:16 INFO - mozhttpd == 0.7 04:20:16 INFO - mozinfo == 0.9 04:20:16 INFO - mozleak == 0.1 04:20:16 INFO - mozlog == 3.1 04:20:16 INFO - moznetwork == 0.27 04:20:16 INFO - mozprocess == 0.22 04:20:16 INFO - mozprofile == 0.28 04:20:16 INFO - mozrunner == 6.11 04:20:16 INFO - mozscreenshot == 0.1 04:20:16 INFO - mozsystemmonitor == 0.0 04:20:16 INFO - moztest == 0.7 04:20:16 INFO - mozversion == 1.4 04:20:16 INFO - psutil == 3.1.1 04:20:16 INFO - requests == 1.2.3 04:20:16 INFO - wsgiref == 0.1.2 04:20:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:16 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:16 INFO - Using env: {'DISPLAY': ':0', 04:20:16 INFO - 'HOME': '/home/cltbld', 04:20:16 INFO - 'LANG': 'en_US.UTF-8', 04:20:16 INFO - 'LANGUAGE': 'en_US:en', 04:20:16 INFO - 'LOGNAME': 'cltbld', 04:20:16 INFO - 'MAIL': '/var/mail/cltbld', 04:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:16 INFO - 'MOZ_NO_REMOTE': '1', 04:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:16 INFO - 'NO_EM_RESTART': '1', 04:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:16 INFO - 'PWD': '/builds/slave/test', 04:20:16 INFO - 'SHELL': '/bin/bash', 04:20:16 INFO - 'SHLVL': '1', 04:20:16 INFO - 'TERM': 'linux', 04:20:16 INFO - 'TMOUT': '86400', 04:20:16 INFO - 'USER': 'cltbld', 04:20:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:16 INFO - '_': '/tools/buildbot/bin/python'} 04:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:17 INFO - Cleaning up... 04:20:17 INFO - Return code: 0 04:20:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:17 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 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:17 INFO - Using env: {'DISPLAY': ':0', 04:20:17 INFO - 'HOME': '/home/cltbld', 04:20:17 INFO - 'LANG': 'en_US.UTF-8', 04:20:17 INFO - 'LANGUAGE': 'en_US:en', 04:20:17 INFO - 'LOGNAME': 'cltbld', 04:20:17 INFO - 'MAIL': '/var/mail/cltbld', 04:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:17 INFO - 'MOZ_NO_REMOTE': '1', 04:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:17 INFO - 'NO_EM_RESTART': '1', 04:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:17 INFO - 'PWD': '/builds/slave/test', 04:20:17 INFO - 'SHELL': '/bin/bash', 04:20:17 INFO - 'SHLVL': '1', 04:20:17 INFO - 'TERM': 'linux', 04:20:17 INFO - 'TMOUT': '86400', 04:20:17 INFO - 'USER': 'cltbld', 04:20:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:17 INFO - '_': '/tools/buildbot/bin/python'} 04:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:17 INFO - Downloading/unpacking jsonschema 04:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:20:19 INFO - Downloading/unpacking functools32 (from jsonschema) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:19 INFO - warning: no files found matching '*.txt' 04:20:19 INFO - no previously-included directories found matching 'build' 04:20:19 INFO - no previously-included directories found matching 'dist' 04:20:19 INFO - no previously-included directories found matching '.git*' 04:20:19 INFO - Installing collected packages: jsonschema, functools32 04:20:19 INFO - Running setup.py install for functools32 04:20:19 INFO - warning: no files found matching '*.txt' 04:20:19 INFO - no previously-included directories found matching 'build' 04:20:19 INFO - no previously-included directories found matching 'dist' 04:20:19 INFO - no previously-included directories found matching '.git*' 04:20:19 INFO - Successfully installed jsonschema functools32 04:20:19 INFO - Cleaning up... 04:20:19 INFO - Return code: 0 04:20:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a5950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eebdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20: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', 'flake8'] in /builds/slave/test/build 04:20: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 flake8 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:19 INFO - Downloading/unpacking flake8 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:20:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:20:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:20:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:22 INFO - no previously-included directories found matching 'docs/_build' 04:20:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:22 INFO - Running setup.py install for pep8 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:22 INFO - no previously-included directories found matching 'docs/_build' 04:20:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:22 INFO - Cleaning up... 04:20:22 INFO - Return code: 0 04:20:22 INFO - Running post-action listener: _resource_record_post_action 04:20:22 INFO - Running post-action listener: _start_resource_monitoring 04:20:22 INFO - Starting resource monitoring. 04:20:22 INFO - ##### 04:20:22 INFO - ##### Running install step. 04:20:22 INFO - ##### 04:20:22 INFO - Running pre-action listener: _resource_record_pre_action 04:20:22 INFO - Running main action method: install 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:22 INFO - Reading from file tmpfile_stdout 04:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:22 INFO - Reading from file tmpfile_stdout 04:20:22 INFO - Output received: 04:20:22 INFO - Usage: mozinstall [options] installer 04:20:22 INFO - Options: 04:20:22 INFO - -h, --help show this help message and exit 04:20:22 INFO - -d DEST, --destination=DEST 04:20:22 INFO - Directory to install application into. [default: 04:20:22 INFO - "/builds/slave/test"] 04:20:22 INFO - --app=APP Application being installed. [default: firefox] 04:20:22 INFO - mkdir: /builds/slave/test/build/application 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:20:38 INFO - Reading from file tmpfile_stdout 04:20:38 INFO - Output received: 04:20:38 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:38 INFO - Running post-action listener: _resource_record_post_action 04:20:38 INFO - ##### 04:20:38 INFO - ##### Running run-tests step. 04:20:38 INFO - ##### 04:20:38 INFO - Running pre-action listener: _resource_record_pre_action 04:20:38 INFO - Running main action method: run_tests 04:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:38 INFO - Python 2.7.3 04:20:38 INFO - Return code: 0 04:20:38 INFO - grabbing minidump binary from tooltool 04:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:38 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 0x1f7e3d0>, '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 0x1ee9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:20:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:20:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:38 INFO - Return code: 0 04:20:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:39 INFO - Return code: 0 04:20:39 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/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:20:39 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/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:39 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/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:20:39 INFO - mozversion application_buildid: 20160111030532 04:20:39 INFO - mozversion application_changeset: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 04:20:39 INFO - mozversion application_display_name: Nightly 04:20:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:39 INFO - mozversion application_name: Firefox 04:20:39 INFO - mozversion application_remotingname: firefox 04:20:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:39 INFO - mozversion application_vendor: Mozilla 04:20:39 INFO - mozversion application_version: 46.0a1 04:20:39 INFO - mozversion platform_buildid: 20160111030532 04:20:39 INFO - mozversion platform_changeset: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 04:20:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:39 INFO - mozversion platform_version: 46.0a1 04:20:39 INFO - using testdate: 1452514839 04:20:39 INFO - actual date: 1452514839 04:20:39 INFO - starting webserver on 'localhost:46218' 04:20:39 INFO - SUITE-START | Running 3 tests 04:20:39 INFO - TEST-START | dromaeo_css 04:20:39 INFO - operating with platform_type : linux_ 04:20:39 INFO - Initialising browser for dromaeo_css test... 04:20:39 INFO - TEST-INFO | started process 23586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplXQTNS/profile http://localhost:46218/getInfo.html) 04:20:43 INFO - PROCESS | 23586 | 04:20:43 INFO - PROCESS | 23586 | (process:23670): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:44 INFO - PROCESS | 23586 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:20:44 INFO - PROCESS | 23586 | __metrics Screen width/height:1600/1200 04:20:44 INFO - PROCESS | 23586 | colorDepth:24 04:20:44 INFO - PROCESS | 23586 | Browser inner width/height: 1024/697 04:20:44 INFO - PROCESS | 23586 | __metrics 04:20:45 INFO - PROCESS | 23586 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:20:45 INFO - TEST-INFO | 23586: exit 0 04:20:45 INFO - Browser initialized. 04:20:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:45 INFO - TEST-INFO | started process 23719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplXQTNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:47 INFO - PROCESS | 23719 | 04:20:47 INFO - PROCESS | 23719 | (process:23776): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:57 INFO - PROCESS | 23719 | RSS: Main: 150269952 04:20:57 INFO - PROCESS | 23719 | 04:21:47 INFO - PROCESS | 23719 | 1452514907545 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:23:59 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46218/tests/dromaeo/cssquery-ext.html) 04:24:00 INFO - PROCESS | 23719 | RSS: Main: 154234880 04:24:00 INFO - PROCESS | 23719 | 04:27:02 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-ext.html (next: http://localhost:46218/tests/dromaeo/cssquery-jquery.html) 04:27:03 INFO - PROCESS | 23719 | RSS: Main: 153513984 04:27:03 INFO - PROCESS | 23719 | 04:30:04 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46218/tests/dromaeo/cssquery-mootools.html) 04:30:05 INFO - PROCESS | 23719 | RSS: Main: 153677824 04:30:05 INFO - PROCESS | 23719 | 04:33:07 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46218/tests/dromaeo/cssquery-prototype.html) 04:33:07 INFO - PROCESS | 23719 | RSS: Main: 152600576 04:33:07 INFO - PROCESS | 23719 | 04:36:10 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46218/tests/dromaeo/cssquery-yui.html) 04:36:11 INFO - PROCESS | 23719 | RSS: Main: 153415680 04:36:11 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | Cycle 1(1): loaded http://localhost:46218/tests/dromaeo/cssquery-yui.html (next: http://localhost:46218/tests/dromaeo/cssquery-dojo.html) 04:39:13 INFO - PROCESS | 23719 | RSS: Main: 156086272 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | __start_tp_report 04:39:13 INFO - PROCESS | 23719 | _x_x_mozilla_page_load 04:39:13 INFO - PROCESS | 23719 | _x_x_mozilla_page_load_details 04:39:13 INFO - PROCESS | 23719 | |i|pagename|runs| 04:39:13 INFO - PROCESS | 23719 | |0;dojo.html;2623.095032213886;2656.7210442903483;2685.5434576122057;2698.7975901807367;2705.648265725456;4377.956220437803;4554.089182163568;4597.356370108188;4603.125406172829;4638.14194374041;4476.8880777980485;4495.3257011448295;4527.660425468095;4639.536046395358;4659.9534004659945;4245.363195520666;4332.718373305741;4376.19040477511;4378.1681480518755;4424.557544245582;4215.3255479123345;4288.378185163165;4315.374270730742;4336.3278691802825;4361.4112094867105;4118.073433477443;4161.542230354658;4217.472815898012;4261.275583150841;4261.808218630169;4262.296721041024;4280.336547835091;4284.978575107105;4286.335617979218;4297.205017071852;4239.957600423987;4248.638865696419;4257.212415703105;4272.807723652443;4287.142571485715;4323.07053983392;4412.75729834859;4482.103579284124;4498.977505112453;4580.633549316047;4900.240462728283;4908.484609116027;4915.655904086715;4931.753412329405;4977.552020318152;4972.676776009584;4973.777870307021;4976.5023497649945;4976.676516026483;5021.046001259785;4379.912401751979;4534.478534968455;4556.8177272908715;4636.536346365337;4657.441107067106;4978.278149668277;4979.526944940225;4987;5006.599472042228;5024.246363045572;4669.089527542164;4811.08589368019;4811.206150985048;4811.591014763784;4866.075445665312;4798.352222449925;4903.387076615423;4976.427710813303;4992.2761199626575;5048.646594738333;4862.149123903303;4876.244182151772;4889.315495830587;4892.779824907888;4937.87655308613;4691.812327506861;4770.045990801784;4876.853694389174;4883.169861123618;4911.901761964741;4089.3252613319064;4138.172365526907;4139.441175441337;4179.226843034048;4181.289180839264;3642.21692336149;3653.3606618841595;3654.232611151635;3684.336819372485;3688.7786732796117;4040.5555388907196;4137.627613514798;4141.171765646883;4237.639800616982;4243.0241044559925;4811.446683631427;4901.950980490221;5012.348394708664;5032.194848824171;5039.798408063636;4119.835206591702;4168.541460439349;4201.34879093741;4227;4242.384854196124;4346.67399944999;4351.086271882877;4358.585934336296;4380.561943805594;4390.1878152541885;4476.955230447654;4586.701864378805;4679.181143299909;4735.573798358164;4764.809407623795;4891.31521586971;4930.359053323188;4931.876703082452;4949.975250123726;4972.751362431792;4509.458864936229;4622.306654001926;4697.318888761179;4701.365315682339;4746.477887432448;4759.690620109682;4763.904721905473;4822.083804077214;4830.106430310404;4901.264810278487;4830.372051633265;4832.806687732451;4854.320395144612;4856.854294371175;4898.902021959612;4535.274356103007;4637.884052898569;4697.966447381571;4711.740854253049;4741.57325840676;4709.599684026896;4764.094821983812;4779.689320194177;4785.401824771903;4812.422509298906;4661.463931647904;4688.390509233778;4688.390509233915;4696.272077827942;4698.130845793539;4569.908601828011;4664.020555683344;4665.4168228971375;4789;4817.807287708592;4634.791434385528;4660;4696.201645720304;4698.906021879611;4704.153252414599 04:39:13 INFO - PROCESS | 23719 | |1;ext.html;492.51979320162843;492.5468568916594;500.0773572758261;517.9974100129499;524.3419508516812;31199.220019499524;31838.363232735388;31871.68128318716;32039.359212815758;32082.67917320826;35609;36347.09223262139;36367;36401.81799091007;36546.63453365466;7559.433042521805;7754.534727916315;7759.45683802134;7775;7777.416693747991;7525.4355923305975;7648.579328136951;7651.617419129049;7855.489393189425;7870.173631768639;7744.419168562352;7891.487053341514;7915.960420197891;7920.564368959705;7927.563983980879;7623.656935437891;7683.116441609231;7720.652570634307;7845.568493732842;7868.173841746649;7603.885941710879;7709.614519274014;7753.496022758559;7758.612069396508;7762.728304509315;37108.814455927546;37304.44043339352;37541.62458375436;37554.061148471235;37655;2945.528715405525;2966.9406611867644;2976.389840082778;3010.232390740347;3422.9144271393166;27841.86079069612;28022.439551209067;28143.859280703466;28284.85857570699;28565.28586785347;3428.142964258935;3451.879184228565;3454.1882657575447;3536.0806190390426;3579.409397449444;211757;214319;215262.92368538215;215441;215758;52003;52746.47253527492;52754.472455274954;52777.472225277255;52938;55388.72305638446;55481.44518554844;55639.16541251884;55716.72141639266;55774.721126394106;11193.776124477465;12080.39598020113;12674.619761407173;13030.08789384734;13097.279649619171;9595.28035397348;9623.615055397706;9628.614855405845;9676.661316854017;9693.273004524688;16980.235889385007;17166.485005449857;17277.91361043212;17362.218700158523;17391.73912391315;7160.641967901584;7415.1472580652835;7510;7514.361279291212;7606.923930760621;842.0947481457458;905.5336501701629;1065.9726377089105;1066.9383962956751;1071.8124328242682;25740.099096531532;25751.484970300487;25865.612015819777;25894;25900.870495647778;922.6724512797995;938.2165891480554;947.8862536495665;968.4286271100085;1079.9406032668278;11899.464524096436;11930.821037684442;11933.761324773455;11962;11964.461599228056;258967;260627;261439;263500;264080;43533;43854;43907;43931.12137757227;43987.56012439899;1187.5249900040053;1191.9826512433413;1194.8088305871192;1198.4367347346733;1210.4008515784567;22212.222572209896;22391.77608223897;22505.774942251024;22690.65964010508;22955.770442295365;34785;34871.825640872645;34976.30047399089;35227.64772352244;35302;244953;247979;249263;249492;249537;24282.514349712554;27758.722412775613;28296.85851570729;28365.149045528666;28456.288592785346;32230.516542252353;32266.193345166557;32397.676023239466;32937.67062329346;33188.33623327471;27881.16356509308;27916.30209244704;27974.173687945422;27980;28766.568501472077;27754.167374978784;27885.860570697827;28187.295317617223;28507.42985140327;28530.144095677162;30521.542176866922;30798.69201308048;30957.690423095482;31247.687523124478;31265.8436707815;25821.870890645427;26653.733462665125;28143.57784633273;28219.57670634901;28532.57201141943;22305.219317323816;22399.88800055989;22428.32715018552;22661.88669056644;22755.08979640796 04:39:13 INFO - PROCESS | 23719 | |2;jquery.html;333.6180073815481;335.5654427516367;336.4868575422481;339.73670405435786;340.7308226501064;14489.49286774963;14749.156355455569;14842.480513182041;15490.148041857694;15842.683146337067;14212.147271163738;14280.857191428082;15197.696046079072;15346.693066138698;15361.539153825403;4607.447106347243;4869.293952376903;5066;5067.6452648314635;5069.493050694938;5080.644354895159;5112.386513618371;5223.947760522403;5811.0702287633985;5833.241678581779;3368.9157771055798;3564.108972756811;5081.085404627165;5775.942240577582;5787.884242315172;5259.395169555473;5270.525652691238;5274.156135018378;5290.841274761763;5293.708846013467;4893.437254715717;5122.078025955327;5123.666961647481;5125.743712814345;5144.022635699205;11668.474918628683;12011;16463.34146634133;18200.63598728018;18436.262549498006;1806.6025474395612;1813.084392381852;1844.1793401936143;1933.8549608779397;1950.151684017457;8709.869351959725;8769.298456123559;9203.263738900872;9773.853392199122;12264.448099835528;1702.0893821805275;1703.7188863837453;1765.5762616971833;1780.5459607800058;1814.0204289683686;48713;50088.49911500838;50166.49833501655;50995.99999999963;51402.7429862852;9269.258459323239;9423.811523769486;9643.855342169873;9661.613535458644;9674.226061915171;12315.507379704712;12381.195222310522;12385.690357741129;12399.25604463717;12418.130730848934;6732.4950628703045;6798.898016529756;6804;6823.1812182538415;6886.827829304308;6426.614403135827;6436.742530298736;6444.516661250425;6447.194100737408;6478.838029049217;4094.242565125461;4161.209370219649;4169.624733773975;4175.164967006611;4204;1693.314207745865;1752.7020406530921;1753.1321995612254;1779.4661601519492;1790.1496789025368;391.1180288449528;399.452749732862;416.66666666666544;437.093031958687;799.5842162075688;9283.164515193665;9634;9742.707718768306;9910.851337229948;14371.425142994372;815.4862436664863;878.1262643669589;883.8630012348096;905.515549181185;924.902885197058;8273.214044665747;8597.355198360023;8756.12438756132;8849.292056635453;9050.818983620422;429745;433224;434279;435154;436268;61970.38029619736;62881.685591571746;63763.043554346725;64556;65557.68884622281;937.1986951156799;955.0926619711163;966.7003228998892;981.7692842182081;981.8821741391079;13006.739865202831;13647.65880852947;13661.726765464833;14022.22877741734;14352.354144063751;27918.3020424491;28316.292092697022;28450.430991380472;28620.42759144764;29001.7099828999;32528.51207231941;32843.83578082094;33065.50401744024;33506.66493335035;33507;6363;6413.743450262124;6607.3062328456745;6629.933700663125;7002.124734408199;9285.86071208946;10025.097741203326;10142.087212150647;10274.660735261219;10478.528466219192;7749.496282741604;8159.79600509992;8335.583220838813;8382.287505562095;8498.235158835487;8292.83414331722;8417.452865563719;8602.171993554666;8705.738827835175;8980.506072165832;8043.87934180976;8082.595870206349;8171.978502687164;8185.795355115932;8215.753527394188;6364.649944252926;6375.330590288138;6375.6812159392775;6409.4231519163495;6471.126397936218;7192.928070719226;8265.95867020661;8319.168083191633;8331.916680833114;8377.246047855722 04:39:13 INFO - PROCESS | 23719 | |3;mootools.html;1396.7206558688263;1415.3206460898768;1545.6985887751894;1708.3081352052407;1715.2795825753183;6245.156903817983;6322.557420980534;7442.47902646815;7656.502327348719;7697.384209263267;7086.681099350529;7343.7062517499235;7409.407247420207;7421.703131874719;7436.144843343017;2138.283674968887;2166.674998750192;2187.3765976696645;2187.824974002076;2190.715207023085;2151.569686062786;2159.1795117855195;2160.481484443738;2171.0664414301846;2175.1516908405733;2165.772593877644;2186.4861757487056;2187.9453013674624;2189.562087582482;2225.8553194042415;2180.6510958246604;2182.5743979923923;2198.1976578548793;2198.714167158259;2199.56008798241;2150.161437039556;2186.2238905188588;2188.6388745856916;2189.102467988117;2192.3642143778284;7634.045744281965;7679.654415551314;7748.496347737436;7767.067951845758;7770.184130666255;4232.576742325774;4294.570542945712;4331.393604895317;4346.282863327548;4351.477822661269;2805.8316501010004;2824.3221626809623;2888.1191236672807;2895.4498645257545;2907.665618453884;888.9333300002461;936.7002559181064;952.7570469530294;962.7208109648194;978.2614126334572;9929.950350248202;9997.500124993794;10018.64934727281;10023.59905603775;10053.79892402148;3918.49059622253;3926.254011737818;3954.426608141803;4005.2590270799415;4012.2376748417705;8605.053444121142;8607.741767746978;8629.352798540134;8639.481631102028;8674.739757807276;4233.1322078973735;4259.361095835588;4264.232438161161;4265.0616864289805;4271.039016221325;3269.869205231764;3335.7831740936763;3905.5313362396696;3908.687305015592;3911.647951684362;3476.0440878758545;3477.669621385964;3480.63453337401;3506.6843984041557;3523.5067090607336;1089.2320913755784;1101.091599430457;1112.3103675721104;1114.025227925565;1121.9102471802237;1177.1507171549158;1180.0972256223995;1200.4057991294364;1220.7192345760525;1242.4409015942863;6980.616066116311;7071.222165561784;7083.787486375417;7099.503034787618;7313.085864266966;457.8786621545293;460.77422063188794;466.1074043207288;467.4390731122666;468.388752677752;5428.321459817523;5503.944960550343;5504.834854954358;5508.862278443071;5527.170924361378;9103.042845788055;9144.588493517807;9371.10974457439;9415.717528474157;9481.383710058824;9124.680636177702;9185.95407022974;9224.30817688676;9224.538773061455;9239.214666753402;7122.7507037253445;7123.501354905107;7140.571565706075;7179.261906782344;7194.820129496699;6847.828804279933;6898.344657257552;6924.549904256207;6961.79114626562;6965.059716938148;7929.365650748042;8251.83496330058;8267.751967440987;8283.29591984688;8347.83304333922;8359.331253499584;8583.914160858312;8594.82810343777;8605.741827745178;8639.179277968582;5390.353157621111;5614.747336369955;6358.586691865014;6540.640264785482;6578.8355291118105;6837.418819400406;6908.412784913338;6945.652717364011;6947.062146610345;6987;6000.789972350947;6071.969640151771;6078.90881636767;6174.138008384429;6215.720292586754;6572.967135164294;6641.501887358564;6658.866822663423;6707.8993815091835;6731.629760363227;6802.217744959393;6824.7952561423235;6881.036654868222;6881.4494840413645;6886.827829304308;6206.410391012847;6272.121902933502;6296.968515157395;6309.968450157719;6441.194850643669;6311.842203944938;6342.968285158545;6354.364563543609;6360.618362898241;6361.173047503795 04:39:13 INFO - PROCESS | 23719 | |4;prototype.html;313.62521786465175;314.47318324985287;320.2426261890628;321.65904141609883;325.0297860885257;5494.175873618954;5521.309836270466;5582.358028826691;5586.134149206874;5613.21415001899;5481.260029895963;5523.475269849368;5523.585731070176;5552.08390615548;5560.026995275831;4113.239050775601;4199.727017743852;4206.852760153388;4216.009237829107;4217.936730949038;4197.118605092935;4198.097409057053;4218.810153543098;4230.598093181143;4232.449781528397;4168.62482376586;4172.916541669165;4175.290200665894;4203;4203.957960420387;4197.874063778077;4214.662826973866;4217.072244106292;4229.91540169198;4230.682698797603;3657.579378371495;3676.1544844685873;3687.539057617798;3690.907727306812;3710.6474884885893;5155.484451554852;5296.9735151324385;5306.230596563515;5306.416294207673;5322.787088516455;4846;4851.757412129379;4851.927221091686;4853.514648535153;4855.878603034917;5732.8853422931725;5748.109043098327;5754.367019627837;5759.424057594249;5765.7981970631245;3998.6801055915457;4005.459262999487;4008.3586626139677;4016.698747593913;4017.5580686124504;5818.301803783531;6063.333033366326;6073.271207455089;6075.149479072933;6078.149059131681;4117.97941010299;4124.484439445069;4125.422440858282;4127.215828992482;4141.7722025288895;4189.895252618709;4197.139586384784;4199.601037901456;4201.747895126302;4211.620954114144;4789.736564488987;4808.471068182497;4822.373091498082;4832.420109586802;4835.516448355136;5649.576281778883;5730.025895597759;5776.249087618667;5784.88430231393;5795.797147099831;1464.0191071981799;1465.9413623454943;1472.094661783017;1472.6244807574;1482.3551754986615;974.6539978307599;979.7844474215661;983.9570055740937;988.2439933450916;988.7640449438202;4991.675541089818;5008.198688209869;5040.571551418097;5048.3941926969;5061.44324124346;5904.7342869570975;6002.069679199731;6011;6088.634681919099;6090.756369745249;5053.67151135175;5055.595552355876;5065.062963351792;5076.873078173001;5087.516685914832;3224.1778346521487;3253.6258330291844;3260.6087269527807;3265.102096923365;3268.2319654881085;5606.495415412633;5711.628744131618;5716.971415142898;5723.914141287884;5755.85610359736;6204.503639708812;6217.098520714561;6220.937790622036;6239.625622462667;6244.594966132584;5727.455891690282;5728.054870946247;5741.224934633771;5745.454181852718;5747;5944.851378715567;6022;6047.758089676364;6064.060070688874;6078.696065196634;5920.407959204045;5996.340402555628;5997.580169388101;5997.790077347272;6014.097885317237;5709.371969083314;5728.885422291448;5751.5398768099285;5752.71236438168;5758.25142731459;4118.608732170439;4160.43834082395;4160.833566657421;4164.479440069991;4176.728512646669;5904.114382842608;6021.367756385692;6033.577649564664;6036.909446358396;6041.516678665784;5785.768569257182;5801.332846722681;5802.912956305574;5808.07070868659;5816.738246778989;5782.479576838105;5821.039528477754;5826.155207494974;5831.94168058331;5834.854128646818;5562.332520097614;5706.144078388275;5707.629004114885;5709.486146246858;5718.085106382959;5825.70871456434;5842.853928651818;5846.123081537803;5850.210221620197;5871.559633027455;5526.447355264441;5653.802116925888;5693;5694.658320500783;5695.829125126253 04:39:13 INFO - PROCESS | 23719 | |5;yui.html;685.2120061928784;697.6372286411063;711.1288671377563;731.6817184524729;759.8062494064013;10348.12040976517;10463.529141188646;10556;10569.943005699435;10582.78834423313;11288.830667539993;11382.487788049537;11426.600068997586;11452.427378631057;11463;749.0898558251723;765.0245936431039;765.3876898481193;765.5062484697366;765.7817522006229;767.2825907776219;788.1842293226512;788.3181048393127;788.562347896917;788.897443332366;819.4141189049828;820.6020080261098;821.4250024982506;821.9301359384459;822.3544517553721;817.5421763812284;818.3085292927497;818.4107442641318;819.6967122164807;820.4789958376414;606.2300877885061;607.5473772039815;607.8966575682144;608.3551435478363;610.5024405109822;11972.161948663597;12000.759984800343;12014.219075760047;12023.15837891348;12025.939870300592;11310.151738619554;11395.202335836495;11428.657140285804;11518.769624607545;11862.52549898003;8462.915370846275;8526.616302266413;8547.658093676246;8559.786005349853;8589.742307730778;3246.1722260823576;3247.5453436518906;3271.1004473769667;3284.6715328467203;3321.4353559894876;36158.81920590407;36960.63039369599;37200.62799371999;37230.627693723254;38413;9392.624295028123;9550.522473876279;9590;9702.563384647709;9703.07820757027;15839;15863.444779432664;15876.364945402054;15892.205389730467;15926.76109858353;6351.396617321347;6377.553571249968;6466.579672321284;6497.317781632955;6531.3142120077655;3672.5042119314085;3673.1000904778502;3679;3782.319182547168;3798.2213646202463;2569.242073588296;2612.2293923292673;2618.0051580399327;2627.6452678888104;2629.2638061342855;490.9803607855646;493.181319010441;496.79279351176984;502.8969061342416;509.0277569841585;444.1383715591806;487.6099120703423;584.1529781816383;599.2958274028;601.7983975368213;7944.721934732373;8010.439269251213;8061.4586451162095;8075.798105047421;8213.507189568525;466.5847395817725;515.1757188498448;575.8819442014377;585.6893265565435;589.8466398736274;3605.8016809075752;3662.1210909381557;3709.0912726382207;3731.8134093295225;3812.5234345706785;44657.330140047925;48199.5180048195;51748.74125629348;52428.47571524312;52528.73735631374;39040;39202;39457.60542394597;39905;39949;33404.83297583545;38746.61253387486;41611.7919410401;42237.36643950343;42668.57331426646;7575.393968482618;7854.803629909298;8186.959065204874;8239.95880020596;8330.333573314;30203.395932080795;30571.54142687817;30755;31414.371712566077;33489.33021339608;35948.28103437864;36233.63766362303;43788.781056094514;43852.56147438485;47181.29228061513;10418.59348987877;10484.318519296221;10752.462376880969;10939.960703733133;11383.317000979967;11149.498272577915;11332.943335283271;11342.092632589538;11679.357635330138;11745.647630571097;8943.552822358726;9165.17513423795;9280.62877484893;9305.302102342486;9381.765455863386;10337.896621033693;10407.323523971221;10615.256932014685;10694.19793515505;11028.117750580095;10367.377957322586;10509.842352364567;10575.471226438802;10666.786664266827;10695.572177112828;8725.91274087251;8932.46405215689;9019.413738107001;9058.773530661787;9145.085491450802;8223.301019413417;8369.874451883348;8440.95779521123;8448.915510844812;8592.054873963983 04:39:13 INFO - PROCESS | 23719 | __end_tp_report 04:39:13 INFO - PROCESS | 23719 | __start_cc_report 04:39:13 INFO - PROCESS | 23719 | _x_x_mozilla_cycle_collect,342 04:39:13 INFO - PROCESS | 23719 | __end_cc_report 04:39:13 INFO - PROCESS | 23719 | __startTimestamp1452515953888__endTimestamp 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | ------- Summary: start ------- 04:39:13 INFO - PROCESS | 23719 | Number of tests: 6 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#0] dojo.html Cycles:165 Average:4529.17 Median:4659.95 stddev:456.15 (9.8%) stddev-sans-first:432.35 04:39:13 INFO - PROCESS | 23719 | Values: 2623.1 2656.7 2685.5 2698.8 2705.6 4378.0 4554.1 4597.4 4603.1 4638.1 4476.9 4495.3 4527.7 4639.5 4660.0 4245.4 4332.7 4376.2 4378.2 4424.6 4215.3 4288.4 4315.4 4336.3 4361.4 4118.1 4161.5 4217.5 4261.3 4261.8 4262.3 4280.3 4285.0 4286.3 4297.2 4240.0 4248.6 4257.2 4272.8 4287.1 4323.1 4412.8 4482.1 4499.0 4580.6 4900.2 4908.5 4915.7 4931.8 4977.6 4972.7 4973.8 4976.5 4976.7 5021.0 4379.9 4534.5 4556.8 4636.5 4657.4 4978.3 4979.5 4987.0 5006.6 5024.2 4669.1 4811.1 4811.2 4811.6 4866.1 4798.4 4903.4 4976.4 4992.3 5048.6 4862.1 4876.2 4889.3 4892.8 4937.9 4691.8 4770.0 4876.9 4883.2 4911.9 4089.3 4138.2 4139.4 4179.2 4181.3 3642.2 3653.4 3654.2 3684.3 3688.8 4040.6 4137.6 4141.2 4237.6 4243.0 4811.4 4902.0 5012.3 5032.2 5039.8 4119.8 4168.5 4201.3 4227.0 4242.4 4346.7 4351.1 4358.6 4380.6 4390.2 4477.0 4586.7 4679.2 4735.6 4764.8 4891.3 4930.4 4931.9 4950.0 4972.8 4509.5 4622.3 4697.3 4701.4 4746.5 4759.7 4763.9 4822.1 4830.1 4901.3 4830.4 4832.8 4854.3 4856.9 4898.9 4535.3 4637.9 4698.0 4711.7 4741.6 4709.6 4764.1 4779.7 4785.4 4812.4 4661.5 4688.4 4688.4 4696.3 4698.1 4569.9 4664.0 4665.4 4789.0 4817.8 4634.8 4660.0 4696.2 4698.9 4704.2 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#1] ext.html Cycles:180 Average:38849.16 Median:31955.52 stddev:63248.74 (197.9%) stddev-sans-first:63360.60 04:39:13 INFO - PROCESS | 23719 | Values: 492.5 492.5 500.1 518.0 524.3 31199.2 31838.4 31871.7 32039.4 32082.7 35609.0 36347.1 36367.0 36401.8 36546.6 7559.4 7754.5 7759.5 7775.0 7777.4 7525.4 7648.6 7651.6 7855.5 7870.2 7744.4 7891.5 7916.0 7920.6 7927.6 7623.7 7683.1 7720.7 7845.6 7868.2 7603.9 7709.6 7753.5 7758.6 7762.7 37108.8 37304.4 37541.6 37554.1 37655.0 2945.5 2966.9 2976.4 3010.2 3422.9 27841.9 28022.4 28143.9 28284.9 28565.3 3428.1 3451.9 3454.2 3536.1 3579.4 211757.0 214319.0 215262.9 215441.0 215758.0 52003.0 52746.5 52754.5 52777.5 52938.0 55388.7 55481.4 55639.2 55716.7 55774.7 11193.8 12080.4 12674.6 13030.1 13097.3 9595.3 9623.6 9628.6 9676.7 9693.3 16980.2 17166.5 17277.9 17362.2 17391.7 7160.6 7415.1 7510.0 7514.4 7606.9 842.1 905.5 1066.0 1066.9 1071.8 25740.1 25751.5 25865.6 25894.0 25900.9 922.7 938.2 947.9 968.4 1079.9 11899.5 11930.8 11933.8 11962.0 11964.5 258967.0 260627.0 261439.0 263500.0 264080.0 43533.0 43854.0 43907.0 43931.1 43987.6 1187.5 1192.0 1194.8 1198.4 1210.4 22212.2 22391.8 22505.8 22690.7 22955.8 34785.0 34871.8 34976.3 35227.6 35302.0 244953.0 247979.0 249263.0 249492.0 249537.0 24282.5 27758.7 28296.9 28365.1 28456.3 32230.5 32266.2 32397.7 32937.7 33188.3 27881.2 27916.3 27974.2 27980.0 28766.6 27754.2 27885.9 28187.3 28507.4 28530.1 30521.5 30798.7 30957.7 31247.7 31265.8 25821.9 26653.7 28143.6 28219.6 28532.6 22305.2 22399.9 22428.3 22661.9 22755.1 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#2] jquery.html Cycles:180 Average:22953.02 Median:5122.87 stddev:70865.57 (1383.3%) stddev-sans-first:71044.01 04:39:13 INFO - PROCESS | 23719 | Values: 333.6 335.6 336.5 339.7 340.7 14489.5 14749.2 14842.5 15490.1 15842.7 14212.1 14280.9 15197.7 15346.7 15361.5 4607.4 4869.3 5066.0 5067.6 5069.5 5080.6 5112.4 5223.9 5811.1 5833.2 3368.9 3564.1 5081.1 5775.9 5787.9 5259.4 5270.5 5274.2 5290.8 5293.7 4893.4 5122.1 5123.7 5125.7 5144.0 11668.5 12011.0 16463.3 18200.6 18436.3 1806.6 1813.1 1844.2 1933.9 1950.2 8709.9 8769.3 9203.3 9773.9 12264.4 1702.1 1703.7 1765.6 1780.5 1814.0 48713.0 50088.5 50166.5 50996.0 51402.7 9269.3 9423.8 9643.9 9661.6 9674.2 12315.5 12381.2 12385.7 12399.3 12418.1 6732.5 6798.9 6804.0 6823.2 6886.8 6426.6 6436.7 6444.5 6447.2 6478.8 4094.2 4161.2 4169.6 4175.2 4204.0 1693.3 1752.7 1753.1 1779.5 1790.1 391.1 399.5 416.7 437.1 799.6 9283.2 9634.0 9742.7 9910.9 14371.4 815.5 878.1 883.9 905.5 924.9 8273.2 8597.4 8756.1 8849.3 9050.8 429745.0 433224.0 434279.0 435154.0 436268.0 61970.4 62881.7 63763.0 64556.0 65557.7 937.2 955.1 966.7 981.8 981.9 13006.7 13647.7 13661.7 14022.2 14352.4 27918.3 28316.3 28450.4 28620.4 29001.7 32528.5 32843.8 33065.5 33506.7 33507.0 6363.0 6413.7 6607.3 6629.9 7002.1 9285.9 10025.1 10142.1 10274.7 10478.5 7749.5 8159.8 8335.6 8382.3 8498.2 8292.8 8417.5 8602.2 8705.7 8980.5 8043.9 8082.6 8172.0 8185.8 8215.8 6364.6 6375.3 6375.7 6409.4 6471.1 7192.9 8266.0 8319.2 8331.9 8377.2 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#3] mootools.html Cycles:180 Average:5187.61 Median:6230.44 stddev:2756.18 (44.2%) stddev-sans-first:2749.18 04:39:13 INFO - PROCESS | 23719 | Values: 1396.7 1415.3 1545.7 1708.3 1715.3 6245.2 6322.6 7442.5 7656.5 7697.4 7086.7 7343.7 7409.4 7421.7 7436.1 2138.3 2166.7 2187.4 2187.8 2190.7 2151.6 2159.2 2160.5 2171.1 2175.2 2165.8 2186.5 2187.9 2189.6 2225.9 2180.7 2182.6 2198.2 2198.7 2199.6 2150.2 2186.2 2188.6 2189.1 2192.4 7634.0 7679.7 7748.5 7767.1 7770.2 4232.6 4294.6 4331.4 4346.3 4351.5 2805.8 2824.3 2888.1 2895.4 2907.7 888.9 936.7 952.8 962.7 978.3 9930.0 9997.5 10018.6 10023.6 10053.8 3918.5 3926.3 3954.4 4005.3 4012.2 8605.1 8607.7 8629.4 8639.5 8674.7 4233.1 4259.4 4264.2 4265.1 4271.0 3269.9 3335.8 3905.5 3908.7 3911.6 3476.0 3477.7 3480.6 3506.7 3523.5 1089.2 1101.1 1112.3 1114.0 1121.9 1177.2 1180.1 1200.4 1220.7 1242.4 6980.6 7071.2 7083.8 7099.5 7313.1 457.9 460.8 466.1 467.4 468.4 5428.3 5503.9 5504.8 5508.9 5527.2 9103.0 9144.6 9371.1 9415.7 9481.4 9124.7 9186.0 9224.3 9224.5 9239.2 7122.8 7123.5 7140.6 7179.3 7194.8 6847.8 6898.3 6924.5 6961.8 6965.1 7929.4 8251.8 8267.8 8283.3 8347.8 8359.3 8583.9 8594.8 8605.7 8639.2 5390.4 5614.7 6358.6 6540.6 6578.8 6837.4 6908.4 6945.7 6947.1 6987.0 6000.8 6072.0 6078.9 6174.1 6215.7 6573.0 6641.5 6658.9 6707.9 6731.6 6802.2 6824.8 6881.0 6881.4 6886.8 6206.4 6272.1 6297.0 6310.0 6441.2 6311.8 6343.0 6354.4 6360.6 6361.2 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#4] prototype.html Cycles:180 Average:4803.36 Median:5539.27 stddev:1423.76 (25.7%) stddev-sans-first:1387.30 04:39:13 INFO - PROCESS | 23719 | Values: 313.6 314.5 320.2 321.7 325.0 5494.2 5521.3 5582.4 5586.1 5613.2 5481.3 5523.5 5523.6 5552.1 5560.0 4113.2 4199.7 4206.9 4216.0 4217.9 4197.1 4198.1 4218.8 4230.6 4232.4 4168.6 4172.9 4175.3 4203.0 4204.0 4197.9 4214.7 4217.1 4229.9 4230.7 3657.6 3676.2 3687.5 3690.9 3710.6 5155.5 5297.0 5306.2 5306.4 5322.8 4846.0 4851.8 4851.9 4853.5 4855.9 5732.9 5748.1 5754.4 5759.4 5765.8 3998.7 4005.5 4008.4 4016.7 4017.6 5818.3 6063.3 6073.3 6075.1 6078.1 4118.0 4124.5 4125.4 4127.2 4141.8 4189.9 4197.1 4199.6 4201.7 4211.6 4789.7 4808.5 4822.4 4832.4 4835.5 5649.6 5730.0 5776.2 5784.9 5795.8 1464.0 1465.9 1472.1 1472.6 1482.4 974.7 979.8 984.0 988.2 988.8 4991.7 5008.2 5040.6 5048.4 5061.4 5904.7 6002.1 6011.0 6088.6 6090.8 5053.7 5055.6 5065.1 5076.9 5087.5 3224.2 3253.6 3260.6 3265.1 3268.2 5606.5 5711.6 5717.0 5723.9 5755.9 6204.5 6217.1 6220.9 6239.6 6244.6 5727.5 5728.1 5741.2 5745.5 5747.0 5944.9 6022.0 6047.8 6064.1 6078.7 5920.4 5996.3 5997.6 5997.8 6014.1 5709.4 5728.9 5751.5 5752.7 5758.3 4118.6 4160.4 4160.8 4164.5 4176.7 5904.1 6021.4 6033.6 6036.9 6041.5 5785.8 5801.3 5802.9 5808.1 5816.7 5782.5 5821.0 5826.2 5831.9 5834.9 5562.3 5706.1 5707.6 5709.5 5718.1 5825.7 5842.9 5846.1 5850.2 5871.6 5526.4 5653.8 5693.0 5694.7 5695.8 04:39:13 INFO - PROCESS | 23719 | 04:39:13 INFO - PROCESS | 23719 | [#5] yui.html Cycles:180 Average:11956.82 Median:22561.96 stddev:13440.59 (59.6%) stddev-sans-first:13451.64 04:39:13 INFO - PROCESS | 23719 | Values: 685.2 697.6 711.1 731.7 759.8 10348.1 10463.5 10556.0 10569.9 10582.8 11288.8 11382.5 11426.6 11452.4 11463.0 749.1 765.0 765.4 765.5 765.8 767.3 788.2 788.3 788.6 788.9 819.4 820.6 821.4 821.9 822.4 817.5 818.3 818.4 819.7 820.5 606.2 607.5 607.9 608.4 610.5 11972.2 12000.8 12014.2 12023.2 12025.9 11310.2 11395.2 11428.7 11518.8 11862.5 8462.9 8526.6 8547.7 8559.8 8589.7 3246.2 3247.5 3271.1 3284.7 3321.4 36158.8 36960.6 37200.6 37230.6 38413.0 9392.6 9550.5 9590.0 9702.6 9703.1 15839.0 15863.4 15876.4 15892.2 15926.8 6351.4 6377.6 6466.6 6497.3 6531.3 3672.5 3673.1 3679.0 3782.3 3798.2 2569.2 2612.2 2618.0 2627.6 2629.3 491.0 493.2 496.8 502.9 509.0 444.1 487.6 584.2 599.3 601.8 7944.7 8010.4 8061.5 8075.8 8213.5 466.6 515.2 575.9 585.7 589.8 3605.8 3662.1 3709.1 3731.8 3812.5 44657.3 48199.5 51748.7 52428.5 52528.7 39040.0 39202.0 39457.6 39905.0 39949.0 33404.8 38746.6 41611.8 42237.4 42668.6 7575.4 7854.8 8187.0 8240.0 8330.3 30203.4 30571.5 30755.0 31414.4 33489.3 35948.3 36233.6 43788.8 43852.6 47181.3 10418.6 10484.3 10752.5 10940.0 11383.3 11149.5 11332.9 11342.1 11679.4 11745.6 8943.6 9165.2 9280.6 9305.3 9381.8 10337.9 10407.3 10615.3 10694.2 11028.1 10367.4 10509.8 10575.5 10666.8 10695.6 8725.9 8932.5 9019.4 9058.8 9145.1 8223.3 8369.9 8441.0 8448.9 8592.1 04:39:13 INFO - PROCESS | 23719 | -------- Summary: end -------- 04:39:13 INFO - PROCESS | 23719 | 04:39:14 INFO - TEST-INFO | 23719: exit 0 04:39:14 INFO - TEST-OK | dromaeo_css | took 1114955ms 04:39:14 INFO - TEST-START | kraken 04:39:14 INFO - operating with platform_type : linux_ 04:39:14 INFO - Initialising browser for kraken test... 04:39:14 INFO - TEST-INFO | started process 23954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iBfJm/profile http://localhost:46218/getInfo.html) 04:39:18 INFO - PROCESS | 23954 | 04:39:18 INFO - PROCESS | 23954 | (process:24026): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:39:18 INFO - PROCESS | 23954 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:39:19 INFO - PROCESS | 23954 | __metrics Screen width/height:1600/1200 04:39:19 INFO - PROCESS | 23954 | colorDepth:24 04:39:19 INFO - PROCESS | 23954 | Browser inner width/height: 1024/697 04:39:19 INFO - PROCESS | 23954 | __metrics 04:39:19 INFO - PROCESS | 23954 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:39:20 INFO - TEST-INFO | 23954: exit 0 04:39:20 INFO - Browser initialized. 04:39:20 INFO - Running cycle 1/1 for kraken test... 04:39:20 INFO - TEST-INFO | started process 24075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iBfJm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:21 INFO - PROCESS | 24075 | 04:39:21 INFO - PROCESS | 24075 | (process:24134): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:39:32 INFO - PROCESS | 24075 | RSS: Main: 149729280 04:39:32 INFO - PROCESS | 24075 | 04:39:35 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46218/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:35 INFO - PROCESS | 24075 | RSS: Main: 149630976 04:39:35 INFO - PROCESS | 24075 | 04:39:38 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46218/tests/kraken/driver.html?testName=audio-dft) 04:39:39 INFO - PROCESS | 24075 | RSS: Main: 150736896 04:39:39 INFO - PROCESS | 24075 | 04:39:41 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46218/tests/kraken/driver.html?testName=audio-fft) 04:39:42 INFO - PROCESS | 24075 | RSS: Main: 146722816 04:39:42 INFO - PROCESS | 24075 | 04:39:44 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46218/tests/kraken/driver.html?testName=audio-oscillator) 04:39:45 INFO - PROCESS | 24075 | RSS: Main: 146624512 04:39:45 INFO - PROCESS | 24075 | 04:39:47 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:48 INFO - PROCESS | 24075 | RSS: Main: 146894848 04:39:48 INFO - PROCESS | 24075 | 04:39:51 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46218/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:51 INFO - PROCESS | 24075 | RSS: Main: 147529728 04:39:51 INFO - PROCESS | 24075 | 04:39:55 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46218/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:55 INFO - PROCESS | 24075 | RSS: Main: 146362368 04:39:55 INFO - PROCESS | 24075 | 04:39:58 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46218/tests/kraken/driver.html?testName=json-parse-financial) 04:39:59 INFO - PROCESS | 24075 | RSS: Main: 147066880 04:39:59 INFO - PROCESS | 24075 | 04:40:01 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:01 INFO - PROCESS | 24075 | RSS: Main: 147931136 04:40:01 INFO - PROCESS | 24075 | 04:40:03 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:04 INFO - PROCESS | 24075 | RSS: Main: 148193280 04:40:04 INFO - PROCESS | 24075 | 04:40:06 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:06 INFO - PROCESS | 24075 | RSS: Main: 148860928 04:40:06 INFO - PROCESS | 24075 | 04:40:09 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:10 INFO - PROCESS | 24075 | RSS: Main: 149024768 04:40:10 INFO - PROCESS | 24075 | 04:40:12 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:13 INFO - PROCESS | 24075 | RSS: Main: 148611072 04:40:13 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | Cycle 1(1): loaded http://localhost:46218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46218/tests/kraken/driver.html?testName=ai-astar) 04:40:15 INFO - PROCESS | 24075 | RSS: Main: 149245952 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | __start_tp_report 04:40:15 INFO - PROCESS | 24075 | _x_x_mozilla_page_load 04:40:15 INFO - PROCESS | 24075 | _x_x_mozilla_page_load_details 04:40:15 INFO - PROCESS | 24075 | |i|pagename|runs| 04:40:15 INFO - PROCESS | 24075 | |0;ai-astar;113;110;114;114;114;123;113;115;114;115 04:40:15 INFO - PROCESS | 24075 | |1;audio-beat-detection;164;139;158;171;136;158;156;134;164;134 04:40:15 INFO - PROCESS | 24075 | |2;audio-dft;162;163;166;161;164;164;168;163;165;163 04:40:15 INFO - PROCESS | 24075 | |3;audio-fft;76;73;73;74;136;72;74;73;74;93 04:40:15 INFO - PROCESS | 24075 | |4;audio-oscillator;98;98;142;98;98;97;135;98;98;142 04:40:15 INFO - PROCESS | 24075 | |5;imaging-gaussian-blur;110;113;112;110;110;110;109;110;110;110 04:40:15 INFO - PROCESS | 24075 | |6;imaging-darkroom;149;148;149;148;149;148;147;148;147;150 04:40:15 INFO - PROCESS | 24075 | |7;imaging-desaturate;97;97;96;97;96;96;97;97;97;96 04:40:15 INFO - PROCESS | 24075 | |8;json-parse-financial;73;71;71;72;71;70;71;73;70;70 04:40:15 INFO - PROCESS | 24075 | |9;json-stringify-tinderbox;68;70;69;69;69;69;69;71;70;69 04:40:15 INFO - PROCESS | 24075 | |10;stanford-crypto-aes;84;92;84;87;84;84;85;86;85;85 04:40:15 INFO - PROCESS | 24075 | |11;stanford-crypto-ccm;122;126;125;130;123;128;122;129;129;122 04:40:15 INFO - PROCESS | 24075 | |12;stanford-crypto-pbkdf2;136;158;160;155;149;159;150;147;156;155 04:40:15 INFO - PROCESS | 24075 | |13;stanford-crypto-sha256-iterative;73;71;74;73;70;72;72;71;70;72 04:40:15 INFO - PROCESS | 24075 | __end_tp_report 04:40:15 INFO - PROCESS | 24075 | __start_cc_report 04:40:15 INFO - PROCESS | 24075 | _x_x_mozilla_cycle_collect,800 04:40:15 INFO - PROCESS | 24075 | __end_cc_report 04:40:15 INFO - PROCESS | 24075 | __startTimestamp1452516015460__endTimestamp 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | ------- Summary: start ------- 04:40:15 INFO - PROCESS | 24075 | Number of tests: 14 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:3.31 (2.9%) stddev-sans-first:3.46 04:40:15 INFO - PROCESS | 24075 | Values: 113.0 110.0 114.0 114.0 114.0 123.0 113.0 115.0 114.0 115.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:158.00 stddev:14.17 (9.0%) stddev-sans-first:14.27 04:40:15 INFO - PROCESS | 24075 | Values: 164.0 139.0 158.0 171.0 136.0 158.0 156.0 134.0 164.0 134.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.02 (1.2%) stddev-sans-first:2.03 04:40:15 INFO - PROCESS | 24075 | Values: 162.0 163.0 166.0 161.0 164.0 164.0 168.0 163.0 165.0 163.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:20.02 (27.1%) stddev-sans-first:21.13 04:40:15 INFO - PROCESS | 24075 | Values: 76.0 73.0 73.0 74.0 136.0 72.0 74.0 73.0 74.0 93.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:98.00 stddev:20.29 (20.7%) stddev-sans-first:21.02 04:40:15 INFO - PROCESS | 24075 | Values: 98.0 98.0 142.0 98.0 98.0 97.0 135.0 98.0 98.0 142.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:1.17 (1.1%) stddev-sans-first:1.24 04:40:15 INFO - PROCESS | 24075 | Values: 110.0 113.0 112.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:40:15 INFO - PROCESS | 24075 | Values: 149.0 148.0 149.0 148.0 149.0 148.0 147.0 148.0 147.0 150.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:40:15 INFO - PROCESS | 24075 | Values: 97.0 97.0 96.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 04:40:15 INFO - PROCESS | 24075 | Values: 73.0 71.0 71.0 72.0 71.0 70.0 71.0 73.0 70.0 70.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 04:40:15 INFO - PROCESS | 24075 | Values: 68.0 70.0 69.0 69.0 69.0 69.0 69.0 71.0 70.0 69.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.46 (2.9%) stddev-sans-first:2.54 04:40:15 INFO - PROCESS | 24075 | Values: 84.0 92.0 84.0 87.0 84.0 84.0 85.0 86.0 85.0 85.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:3.24 (2.6%) stddev-sans-first:3.16 04:40:15 INFO - PROCESS | 24075 | Values: 122.0 126.0 125.0 130.0 123.0 128.0 122.0 129.0 129.0 122.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:155.50 stddev:7.26 (4.7%) stddev-sans-first:4.64 04:40:15 INFO - PROCESS | 24075 | Values: 136.0 158.0 160.0 155.0 149.0 159.0 150.0 147.0 156.0 155.0 04:40:15 INFO - PROCESS | 24075 | 04:40:15 INFO - PROCESS | 24075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.32 (1.8%) stddev-sans-first:1.32 04:40:15 INFO - PROCESS | 24075 | Values: 73.0 71.0 74.0 73.0 70.0 72.0 72.0 71.0 70.0 72.0 04:40:15 INFO - PROCESS | 24075 | -------- Summary: end -------- 04:40:15 INFO - PROCESS | 24075 | 04:40:16 INFO - TEST-INFO | 24075: exit 0 04:40:16 INFO - TEST-OK | kraken | took 61773ms 04:40:16 INFO - TEST-START | v8_7 04:40:16 INFO - operating with platform_type : linux_ 04:40:16 INFO - Initialising browser for v8_7 test... 04:40:16 INFO - TEST-INFO | started process 24362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8A3w9/profile http://localhost:46218/getInfo.html) 04:40:20 INFO - PROCESS | 24362 | 04:40:20 INFO - PROCESS | 24362 | (process:24436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:20 INFO - PROCESS | 24362 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:40:21 INFO - PROCESS | 24362 | __metrics Screen width/height:1600/1200 04:40:21 INFO - PROCESS | 24362 | colorDepth:24 04:40:21 INFO - PROCESS | 24362 | Browser inner width/height: 1024/697 04:40:21 INFO - PROCESS | 24362 | __metrics 04:40:21 INFO - PROCESS | 24362 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:40:22 INFO - TEST-INFO | 24362: exit 0 04:40:22 INFO - Browser initialized. 04:40:22 INFO - Running cycle 1/1 for v8_7 test... 04:40:22 INFO - TEST-INFO | started process 24485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8A3w9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:24 INFO - PROCESS | 24485 | 04:40:24 INFO - PROCESS | 24485 | (process:24542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:34 INFO - PROCESS | 24485 | RSS: Main: 150888448 04:40:34 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | Cycle 1(1): loaded http://localhost:46218/tests/v8_7/run.html (next: http://localhost:46218/tests/v8_7/run.html) 04:40:57 INFO - PROCESS | 24485 | RSS: Main: 146046976 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | __start_tp_report 04:40:57 INFO - PROCESS | 24485 | _x_x_mozilla_page_load 04:40:57 INFO - PROCESS | 24485 | _x_x_mozilla_page_load_details 04:40:57 INFO - PROCESS | 24485 | |i|pagename|runs| 04:40:57 INFO - PROCESS | 24485 | |0;Richards;169.548999660902 04:40:57 INFO - PROCESS | 24485 | |1;DeltaBlue;187.30099269526127 04:40:57 INFO - PROCESS | 24485 | |2;Encrypt;277.85495971103086 04:40:57 INFO - PROCESS | 24485 | |3;Decrypt;5181.347150259067 04:40:57 INFO - PROCESS | 24485 | |4;RayTrace;1106.1946902654868 04:40:57 INFO - PROCESS | 24485 | |5;Earley;726.7441860465116 04:40:57 INFO - PROCESS | 24485 | |6;Boyer;12696.20253164557 04:40:57 INFO - PROCESS | 24485 | |7;RegExp;42872.34042553192 04:40:57 INFO - PROCESS | 24485 | |8;Splay;602.7727546714889 04:40:57 INFO - PROCESS | 24485 | |9;NavierStokes;4921.568627450981 04:40:57 INFO - PROCESS | 24485 | __end_tp_report 04:40:57 INFO - PROCESS | 24485 | __startTimestamp1452516057317__endTimestamp 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | ------- Summary: start ------- 04:40:57 INFO - PROCESS | 24485 | Number of tests: 10 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#0] Richards Cycles:1 Average:169.55 Median:169.55 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 169.5 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#1] DeltaBlue Cycles:1 Average:187.30 Median:187.30 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 187.3 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 277.9 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 5181.3 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 1106.2 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 726.7 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#6] Boyer Cycles:1 Average:12696.20 Median:12696.20 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 12696.2 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#7] RegExp Cycles:1 Average:42872.34 Median:42872.34 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 42872.3 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#8] Splay Cycles:1 Average:602.77 Median:602.77 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 602.8 04:40:57 INFO - PROCESS | 24485 | 04:40:57 INFO - PROCESS | 24485 | [#9] NavierStokes Cycles:1 Average:4921.57 Median:4921.57 stddev:0.00 (0.0%) 04:40:57 INFO - PROCESS | 24485 | Values: 4921.6 04:40:57 INFO - PROCESS | 24485 | -------- Summary: end -------- 04:40:57 INFO - PROCESS | 24485 | 04:40:58 INFO - TEST-INFO | 24485: exit 0 04:40:58 INFO - TEST-OK | v8_7 | took 41820ms 04:40:58 INFO - SUITE-END | took 1218s 04:40:58 INFO - Completed test suite (00:20:18) 04:40:58 INFO - Working with test: dromaeo_css 04:40:58 INFO - Generating results file: dromaeo_css 04:40:58 INFO - Working with test: kraken 04:40:58 INFO - Generating results file: kraken 04:40:58 INFO - javascript benchmark 04:40:58 INFO - Working with test: v8_7 04:40:58 INFO - Generating results file: v8_7 04:40:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:40:58 INFO - process_Request line: dromaeo_css 6121.15 graph.html#tests=[[72,94,43]] 04:40:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:58 INFO - process_Request line: kraken 1553.30 graph.html#tests=[[232,94,43]] 04:40:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:40:58 INFO - process_Request line: v8_7 20083.44 graph.html#tests=[[230,94,43]] 04:40:58 INFO - RETURN: dromaeo_css: 6121.15 04:40:58 INFO - RETURN: kraken: 1553.30 04:40:58 INFO - RETURN: v8_7: 20083.44 04:40:58 INFO - javascript benchmark 04:40:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.095032213886, 2656.7210442903483, 2685.5434576122057, 2698.7975901807367, 2705.648265725456, 4377.956220437803, 4554.089182163568, 4597.356370108188, 4603.125406172829, 4638.14194374041, 4476.8880777980485, 4495.3257011448295, 4527.660425468095, 4639.536046395358, 4659.9534004659945, 4245.363195520666, 4332.718373305741, 4376.19040477511, 4378.1681480518755, 4424.557544245582, 4215.3255479123345, 4288.378185163165, 4315.374270730742, 4336.3278691802825, 4361.4112094867105, 4118.073433477443, 4161.542230354658, 4217.472815898012, 4261.275583150841, 4261.808218630169, 4262.296721041024, 4280.336547835091, 4284.978575107105, 4286.335617979218, 4297.205017071852, 4239.957600423987, 4248.638865696419, 4257.212415703105, 4272.807723652443, 4287.142571485715, 4323.07053983392, 4412.75729834859, 4482.103579284124, 4498.977505112453, 4580.633549316047, 4900.240462728283, 4908.484609116027, 4915.655904086715, 4931.753412329405, 4977.552020318152, 4972.676776009584, 4973.777870307021, 4976.5023497649945, 4976.676516026483, 5021.046001259785, 4379.912401751979, 4534.478534968455, 4556.8177272908715, 4636.536346365337, 4657.441107067106, 4978.278149668277, 4979.526944940225, 4987.0, 5006.599472042228, 5024.246363045572, 4669.089527542164, 4811.08589368019, 4811.206150985048, 4811.591014763784, 4866.075445665312, 4798.352222449925, 4903.387076615423, 4976.427710813303, 4992.2761199626575, 5048.646594738333, 4862.149123903303, 4876.244182151772, 4889.315495830587, 4892.779824907888, 4937.87655308613, 4691.812327506861, 4770.045990801784, 4876.853694389174, 4883.169861123618, 4911.901761964741, 4089.3252613319064, 4138.172365526907, 4139.441175441337, 4179.226843034048, 4181.289180839264, 3642.21692336149, 3653.3606618841595, 3654.232611151635, 3684.336819372485, 3688.7786732796117, 4040.5555388907196, 4137.627613514798, 4141.171765646883, 4237.639800616982, 4243.0241044559925, 4811.446683631427, 4901.950980490221, 5012.348394708664, 5032.194848824171, 5039.798408063636, 4119.835206591702, 4168.541460439349, 4201.34879093741, 4227.0, 4242.384854196124, 4346.67399944999, 4351.086271882877, 4358.585934336296, 4380.561943805594, 4390.1878152541885, 4476.955230447654, 4586.701864378805, 4679.181143299909, 4735.573798358164, 4764.809407623795, 4891.31521586971, 4930.359053323188, 4931.876703082452, 4949.975250123726, 4972.751362431792, 4509.458864936229, 4622.306654001926, 4697.318888761179, 4701.365315682339, 4746.477887432448, 4759.690620109682, 4763.904721905473, 4822.083804077214, 4830.106430310404, 4901.264810278487, 4830.372051633265, 4832.806687732451, 4854.320395144612, 4856.854294371175, 4898.902021959612, 4535.274356103007, 4637.884052898569, 4697.966447381571, 4711.740854253049, 4741.57325840676, 4709.599684026896, 4764.094821983812, 4779.689320194177, 4785.401824771903, 4812.422509298906, 4661.463931647904, 4688.390509233778, 4688.390509233915, 4696.272077827942, 4698.130845793539, 4569.908601828011, 4664.020555683344, 4665.4168228971375, 4789.0, 4817.807287708592, 4634.791434385528, 4660.0, 4696.201645720304, 4698.906021879611, 4704.153252414599], "unit": "score", "name": "dojo.html", "value": 4502.039334474315}, {"lowerIsBetter": false, "replicates": [492.51979320162843, 492.5468568916594, 500.0773572758261, 517.9974100129499, 524.3419508516812, 31199.220019499524, 31838.363232735388, 31871.68128318716, 32039.359212815758, 32082.67917320826, 35609.0, 36347.09223262139, 36367.0, 36401.81799091007, 36546.63453365466, 7559.433042521805, 7754.534727916315, 7759.45683802134, 7775.0, 7777.416693747991, 7525.4355923305975, 7648.579328136951, 7651.617419129049, 7855.489393189425, 7870.173631768639, 7744.419168562352, 7891.487053341514, 7915.960420197891, 7920.564368959705, 7927.563983980879, 7623.656935437891, 7683.116441609231, 7720.652570634307, 7845.568493732842, 7868.173841746649, 7603.885941710879, 7709.614519274014, 7753.496022758559, 7758.612069396508, 7762.728304509315, 37108.814455927546, 37304.44043339352, 37541.62458375436, 37554.061148471235, 37655.0, 2945.528715405525, 2966.9406611867644, 2976.389840082778, 3010.232390740347, 3422.9144271393166, 27841.86079069612, 28022.439551209067, 28143.859280703466, 28284.85857570699, 28565.28586785347, 3428.142964258935, 3451.879184228565, 3454.1882657575447, 3536.0806190390426, 3579.409397449444, 211757.0, 214319.0, 215262.92368538215, 215441.0, 215758.0, 52003.0, 52746.47253527492, 52754.472455274954, 52777.472225277255, 52938.0, 55388.72305638446, 55481.44518554844, 55639.16541251884, 55716.72141639266, 55774.721126394106, 11193.776124477465, 12080.39598020113, 12674.619761407173, 13030.08789384734, 13097.279649619171, 9595.28035397348, 9623.615055397706, 9628.614855405845, 9676.661316854017, 9693.273004524688, 16980.235889385007, 17166.485005449857, 17277.91361043212, 17362.218700158523, 17391.73912391315, 7160.641967901584, 7415.1472580652835, 7510.0, 7514.361279291212, 7606.923930760621, 842.0947481457458, 905.5336501701629, 1065.9726377089105, 1066.9383962956751, 1071.8124328242682, 25740.099096531532, 25751.484970300487, 25865.612015819777, 25894.0, 25900.870495647778, 922.6724512797995, 938.2165891480554, 947.8862536495665, 968.4286271100085, 1079.9406032668278, 11899.464524096436, 11930.821037684442, 11933.761324773455, 11962.0, 11964.461599228056, 258967.0, 260627.0, 261439.0, 263500.0, 264080.0, 43533.0, 43854.0, 43907.0, 43931.12137757227, 43987.56012439899, 1187.5249900040053, 1191.9826512433413, 1194.8088305871192, 1198.4367347346733, 1210.4008515784567, 22212.222572209896, 22391.77608223897, 22505.774942251024, 22690.65964010508, 22955.770442295365, 34785.0, 34871.825640872645, 34976.30047399089, 35227.64772352244, 35302.0, 244953.0, 247979.0, 249263.0, 249492.0, 249537.0, 24282.514349712554, 27758.722412775613, 28296.85851570729, 28365.149045528666, 28456.288592785346, 32230.516542252353, 32266.193345166557, 32397.676023239466, 32937.67062329346, 33188.33623327471, 27881.16356509308, 27916.30209244704, 27974.173687945422, 27980.0, 28766.568501472077, 27754.167374978784, 27885.860570697827, 28187.295317617223, 28507.42985140327, 28530.144095677162, 30521.542176866922, 30798.69201308048, 30957.690423095482, 31247.687523124478, 31265.8436707815, 25821.870890645427, 26653.733462665125, 28143.57784633273, 28219.57670634901, 28532.57201141943, 22305.219317323816, 22399.88800055989, 22428.32715018552, 22661.88669056644, 22755.08979640796], "unit": "score", "name": "ext.html", "value": 15937.37664047554}, {"lowerIsBetter": false, "replicates": [333.6180073815481, 335.5654427516367, 336.4868575422481, 339.73670405435786, 340.7308226501064, 14489.49286774963, 14749.156355455569, 14842.480513182041, 15490.148041857694, 15842.683146337067, 14212.147271163738, 14280.857191428082, 15197.696046079072, 15346.693066138698, 15361.539153825403, 4607.447106347243, 4869.293952376903, 5066.0, 5067.6452648314635, 5069.493050694938, 5080.644354895159, 5112.386513618371, 5223.947760522403, 5811.0702287633985, 5833.241678581779, 3368.9157771055798, 3564.108972756811, 5081.085404627165, 5775.942240577582, 5787.884242315172, 5259.395169555473, 5270.525652691238, 5274.156135018378, 5290.841274761763, 5293.708846013467, 4893.437254715717, 5122.078025955327, 5123.666961647481, 5125.743712814345, 5144.022635699205, 11668.474918628683, 12011.0, 16463.34146634133, 18200.63598728018, 18436.262549498006, 1806.6025474395612, 1813.084392381852, 1844.1793401936143, 1933.8549608779397, 1950.151684017457, 8709.869351959725, 8769.298456123559, 9203.263738900872, 9773.853392199122, 12264.448099835528, 1702.0893821805275, 1703.7188863837453, 1765.5762616971833, 1780.5459607800058, 1814.0204289683686, 48713.0, 50088.49911500838, 50166.49833501655, 50995.99999999963, 51402.7429862852, 9269.258459323239, 9423.811523769486, 9643.855342169873, 9661.613535458644, 9674.226061915171, 12315.507379704712, 12381.195222310522, 12385.690357741129, 12399.25604463717, 12418.130730848934, 6732.4950628703045, 6798.898016529756, 6804.0, 6823.1812182538415, 6886.827829304308, 6426.614403135827, 6436.742530298736, 6444.516661250425, 6447.194100737408, 6478.838029049217, 4094.242565125461, 4161.209370219649, 4169.624733773975, 4175.164967006611, 4204.0, 1693.314207745865, 1752.7020406530921, 1753.1321995612254, 1779.4661601519492, 1790.1496789025368, 391.1180288449528, 399.452749732862, 416.66666666666544, 437.093031958687, 799.5842162075688, 9283.164515193665, 9634.0, 9742.707718768306, 9910.851337229948, 14371.425142994372, 815.4862436664863, 878.1262643669589, 883.8630012348096, 905.515549181185, 924.902885197058, 8273.214044665747, 8597.355198360023, 8756.12438756132, 8849.292056635453, 9050.818983620422, 429745.0, 433224.0, 434279.0, 435154.0, 436268.0, 61970.38029619736, 62881.685591571746, 63763.043554346725, 64556.0, 65557.68884622281, 937.1986951156799, 955.0926619711163, 966.7003228998892, 981.7692842182081, 981.8821741391079, 13006.739865202831, 13647.65880852947, 13661.726765464833, 14022.22877741734, 14352.354144063751, 27918.3020424491, 28316.292092697022, 28450.430991380472, 28620.42759144764, 29001.7099828999, 32528.51207231941, 32843.83578082094, 33065.50401744024, 33506.66493335035, 33507.0, 6363.0, 6413.743450262124, 6607.3062328456745, 6629.933700663125, 7002.124734408199, 9285.86071208946, 10025.097741203326, 10142.087212150647, 10274.660735261219, 10478.528466219192, 7749.496282741604, 8159.79600509992, 8335.583220838813, 8382.287505562095, 8498.235158835487, 8292.83414331722, 8417.452865563719, 8602.171993554666, 8705.738827835175, 8980.506072165832, 8043.87934180976, 8082.595870206349, 8171.978502687164, 8185.795355115932, 8215.753527394188, 6364.649944252926, 6375.330590288138, 6375.6812159392775, 6409.4231519163495, 6471.126397936218, 7192.928070719226, 8265.95867020661, 8319.168083191633, 8331.916680833114, 8377.246047855722], "unit": "score", "name": "jquery.html", "value": 7176.803817308637}, {"lowerIsBetter": false, "replicates": [1396.7206558688263, 1415.3206460898768, 1545.6985887751894, 1708.3081352052407, 1715.2795825753183, 6245.156903817983, 6322.557420980534, 7442.47902646815, 7656.502327348719, 7697.384209263267, 7086.681099350529, 7343.7062517499235, 7409.407247420207, 7421.703131874719, 7436.144843343017, 2138.283674968887, 2166.674998750192, 2187.3765976696645, 2187.824974002076, 2190.715207023085, 2151.569686062786, 2159.1795117855195, 2160.481484443738, 2171.0664414301846, 2175.1516908405733, 2165.772593877644, 2186.4861757487056, 2187.9453013674624, 2189.562087582482, 2225.8553194042415, 2180.6510958246604, 2182.5743979923923, 2198.1976578548793, 2198.714167158259, 2199.56008798241, 2150.161437039556, 2186.2238905188588, 2188.6388745856916, 2189.102467988117, 2192.3642143778284, 7634.045744281965, 7679.654415551314, 7748.496347737436, 7767.067951845758, 7770.184130666255, 4232.576742325774, 4294.570542945712, 4331.393604895317, 4346.282863327548, 4351.477822661269, 2805.8316501010004, 2824.3221626809623, 2888.1191236672807, 2895.4498645257545, 2907.665618453884, 888.9333300002461, 936.7002559181064, 952.7570469530294, 962.7208109648194, 978.2614126334572, 9929.950350248202, 9997.500124993794, 10018.64934727281, 10023.59905603775, 10053.79892402148, 3918.49059622253, 3926.254011737818, 3954.426608141803, 4005.2590270799415, 4012.2376748417705, 8605.053444121142, 8607.741767746978, 8629.352798540134, 8639.481631102028, 8674.739757807276, 4233.1322078973735, 4259.361095835588, 4264.232438161161, 4265.0616864289805, 4271.039016221325, 3269.869205231764, 3335.7831740936763, 3905.5313362396696, 3908.687305015592, 3911.647951684362, 3476.0440878758545, 3477.669621385964, 3480.63453337401, 3506.6843984041557, 3523.5067090607336, 1089.2320913755784, 1101.091599430457, 1112.3103675721104, 1114.025227925565, 1121.9102471802237, 1177.1507171549158, 1180.0972256223995, 1200.4057991294364, 1220.7192345760525, 1242.4409015942863, 6980.616066116311, 7071.222165561784, 7083.787486375417, 7099.503034787618, 7313.085864266966, 457.8786621545293, 460.77422063188794, 466.1074043207288, 467.4390731122666, 468.388752677752, 5428.321459817523, 5503.944960550343, 5504.834854954358, 5508.862278443071, 5527.170924361378, 9103.042845788055, 9144.588493517807, 9371.10974457439, 9415.717528474157, 9481.383710058824, 9124.680636177702, 9185.95407022974, 9224.30817688676, 9224.538773061455, 9239.214666753402, 7122.7507037253445, 7123.501354905107, 7140.571565706075, 7179.261906782344, 7194.820129496699, 6847.828804279933, 6898.344657257552, 6924.549904256207, 6961.79114626562, 6965.059716938148, 7929.365650748042, 8251.83496330058, 8267.751967440987, 8283.29591984688, 8347.83304333922, 8359.331253499584, 8583.914160858312, 8594.82810343777, 8605.741827745178, 8639.179277968582, 5390.353157621111, 5614.747336369955, 6358.586691865014, 6540.640264785482, 6578.8355291118105, 6837.418819400406, 6908.412784913338, 6945.652717364011, 6947.062146610345, 6987.0, 6000.789972350947, 6071.969640151771, 6078.90881636767, 6174.138008384429, 6215.720292586754, 6572.967135164294, 6641.501887358564, 6658.866822663423, 6707.8993815091835, 6731.629760363227, 6802.217744959393, 6824.7952561423235, 6881.036654868222, 6881.4494840413645, 6886.827829304308, 6206.410391012847, 6272.121902933502, 6296.968515157395, 6309.968450157719, 6441.194850643669, 6311.842203944938, 6342.968285158545, 6354.364563543609, 6360.618362898241, 6361.173047503795], "unit": "score", "name": "mootools.html", "value": 4178.702410048228}, {"lowerIsBetter": false, "replicates": [313.62521786465175, 314.47318324985287, 320.2426261890628, 321.65904141609883, 325.0297860885257, 5494.175873618954, 5521.309836270466, 5582.358028826691, 5586.134149206874, 5613.21415001899, 5481.260029895963, 5523.475269849368, 5523.585731070176, 5552.08390615548, 5560.026995275831, 4113.239050775601, 4199.727017743852, 4206.852760153388, 4216.009237829107, 4217.936730949038, 4197.118605092935, 4198.097409057053, 4218.810153543098, 4230.598093181143, 4232.449781528397, 4168.62482376586, 4172.916541669165, 4175.290200665894, 4203.0, 4203.957960420387, 4197.874063778077, 4214.662826973866, 4217.072244106292, 4229.91540169198, 4230.682698797603, 3657.579378371495, 3676.1544844685873, 3687.539057617798, 3690.907727306812, 3710.6474884885893, 5155.484451554852, 5296.9735151324385, 5306.230596563515, 5306.416294207673, 5322.787088516455, 4846.0, 4851.757412129379, 4851.927221091686, 4853.514648535153, 4855.878603034917, 5732.8853422931725, 5748.109043098327, 5754.367019627837, 5759.424057594249, 5765.7981970631245, 3998.6801055915457, 4005.459262999487, 4008.3586626139677, 4016.698747593913, 4017.5580686124504, 5818.301803783531, 6063.333033366326, 6073.271207455089, 6075.149479072933, 6078.149059131681, 4117.97941010299, 4124.484439445069, 4125.422440858282, 4127.215828992482, 4141.7722025288895, 4189.895252618709, 4197.139586384784, 4199.601037901456, 4201.747895126302, 4211.620954114144, 4789.736564488987, 4808.471068182497, 4822.373091498082, 4832.420109586802, 4835.516448355136, 5649.576281778883, 5730.025895597759, 5776.249087618667, 5784.88430231393, 5795.797147099831, 1464.0191071981799, 1465.9413623454943, 1472.094661783017, 1472.6244807574, 1482.3551754986615, 974.6539978307599, 979.7844474215661, 983.9570055740937, 988.2439933450916, 988.7640449438202, 4991.675541089818, 5008.198688209869, 5040.571551418097, 5048.3941926969, 5061.44324124346, 5904.7342869570975, 6002.069679199731, 6011.0, 6088.634681919099, 6090.756369745249, 5053.67151135175, 5055.595552355876, 5065.062963351792, 5076.873078173001, 5087.516685914832, 3224.1778346521487, 3253.6258330291844, 3260.6087269527807, 3265.102096923365, 3268.2319654881085, 5606.495415412633, 5711.628744131618, 5716.971415142898, 5723.914141287884, 5755.85610359736, 6204.503639708812, 6217.098520714561, 6220.937790622036, 6239.625622462667, 6244.594966132584, 5727.455891690282, 5728.054870946247, 5741.224934633771, 5745.454181852718, 5747.0, 5944.851378715567, 6022.0, 6047.758089676364, 6064.060070688874, 6078.696065196634, 5920.407959204045, 5996.340402555628, 5997.580169388101, 5997.790077347272, 6014.097885317237, 5709.371969083314, 5728.885422291448, 5751.5398768099285, 5752.71236438168, 5758.25142731459, 4118.608732170439, 4160.43834082395, 4160.833566657421, 4164.479440069991, 4176.728512646669, 5904.114382842608, 6021.367756385692, 6033.577649564664, 6036.909446358396, 6041.516678665784, 5785.768569257182, 5801.332846722681, 5802.912956305574, 5808.07070868659, 5816.738246778989, 5782.479576838105, 5821.039528477754, 5826.155207494974, 5831.94168058331, 5834.854128646818, 5562.332520097614, 5706.144078388275, 5707.629004114885, 5709.486146246858, 5718.085106382959, 5825.70871456434, 5842.853928651818, 5846.123081537803, 5850.210221620197, 5871.559633027455, 5526.447355264441, 5653.802116925888, 5693.0, 5694.658320500783, 5695.829125126253], "unit": "score", "name": "prototype.html", "value": 4345.3667754921}, {"lowerIsBetter": false, "replicates": [685.2120061928784, 697.6372286411063, 711.1288671377563, 731.6817184524729, 759.8062494064013, 10348.12040976517, 10463.529141188646, 10556.0, 10569.943005699435, 10582.78834423313, 11288.830667539993, 11382.487788049537, 11426.600068997586, 11452.427378631057, 11463.0, 749.0898558251723, 765.0245936431039, 765.3876898481193, 765.5062484697366, 765.7817522006229, 767.2825907776219, 788.1842293226512, 788.3181048393127, 788.562347896917, 788.897443332366, 819.4141189049828, 820.6020080261098, 821.4250024982506, 821.9301359384459, 822.3544517553721, 817.5421763812284, 818.3085292927497, 818.4107442641318, 819.6967122164807, 820.4789958376414, 606.2300877885061, 607.5473772039815, 607.8966575682144, 608.3551435478363, 610.5024405109822, 11972.161948663597, 12000.759984800343, 12014.219075760047, 12023.15837891348, 12025.939870300592, 11310.151738619554, 11395.202335836495, 11428.657140285804, 11518.769624607545, 11862.52549898003, 8462.915370846275, 8526.616302266413, 8547.658093676246, 8559.786005349853, 8589.742307730778, 3246.1722260823576, 3247.5453436518906, 3271.1004473769667, 3284.6715328467203, 3321.4353559894876, 36158.81920590407, 36960.63039369599, 37200.62799371999, 37230.627693723254, 38413.0, 9392.624295028123, 9550.522473876279, 9590.0, 9702.563384647709, 9703.07820757027, 15839.0, 15863.444779432664, 15876.364945402054, 15892.205389730467, 15926.76109858353, 6351.396617321347, 6377.553571249968, 6466.579672321284, 6497.317781632955, 6531.3142120077655, 3672.5042119314085, 3673.1000904778502, 3679.0, 3782.319182547168, 3798.2213646202463, 2569.242073588296, 2612.2293923292673, 2618.0051580399327, 2627.6452678888104, 2629.2638061342855, 490.9803607855646, 493.181319010441, 496.79279351176984, 502.8969061342416, 509.0277569841585, 444.1383715591806, 487.6099120703423, 584.1529781816383, 599.2958274028, 601.7983975368213, 7944.721934732373, 8010.439269251213, 8061.4586451162095, 8075.798105047421, 8213.507189568525, 466.5847395817725, 515.1757188498448, 575.8819442014377, 585.6893265565435, 589.8466398736274, 3605.8016809075752, 3662.1210909381557, 3709.0912726382207, 3731.8134093295225, 3812.5234345706785, 44657.330140047925, 48199.5180048195, 51748.74125629348, 52428.47571524312, 52528.73735631374, 39040.0, 39202.0, 39457.60542394597, 39905.0, 39949.0, 33404.83297583545, 38746.61253387486, 41611.7919410401, 42237.36643950343, 42668.57331426646, 7575.393968482618, 7854.803629909298, 8186.959065204874, 8239.95880020596, 8330.333573314, 30203.395932080795, 30571.54142687817, 30755.0, 31414.371712566077, 33489.33021339608, 35948.28103437864, 36233.63766362303, 43788.781056094514, 43852.56147438485, 47181.29228061513, 10418.59348987877, 10484.318519296221, 10752.462376880969, 10939.960703733133, 11383.317000979967, 11149.498272577915, 11332.943335283271, 11342.092632589538, 11679.357635330138, 11745.647630571097, 8943.552822358726, 9165.17513423795, 9280.62877484893, 9305.302102342486, 9381.765455863386, 10337.896621033693, 10407.323523971221, 10615.256932014685, 10694.19793515505, 11028.117750580095, 10367.377957322586, 10509.842352364567, 10575.471226438802, 10666.786664266827, 10695.572177112828, 8725.91274087251, 8932.46405215689, 9019.413738107001, 9058.773530661787, 9145.085491450802, 8223.301019413417, 8369.874451883348, 8440.95779521123, 8448.915510844812, 8592.054873963983], "unit": "score", "name": "yui.html", "value": 5625.119399710871}], "name": "dromaeo_css", "value": 6121.14598680571}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 114.0, 114.0, 123.0, 113.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [164.0, 139.0, 158.0, 171.0, 136.0, 158.0, 156.0, 134.0, 164.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 166.0, 161.0, 164.0, 164.0, 168.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 73.0, 74.0, 136.0, 72.0, 74.0, 73.0, 74.0, 93.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 142.0, 98.0, 98.0, 97.0, 135.0, 98.0, 98.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 112.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 71.0, 72.0, 71.0, 70.0, 71.0, 73.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 84.0, 87.0, 84.0, 84.0, 85.0, 86.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 125.0, 130.0, 123.0, 128.0, 122.0, 129.0, 129.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [136.0, 158.0, 160.0, 155.0, 149.0, 159.0, 150.0, 147.0, 156.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 73.0, 70.0, 72.0, 72.0, 71.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1553.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.548999660902], "unit": "score", "name": "Richards", "value": 208.21119599999997}, {"lowerIsBetter": false, "replicates": [187.30099269526127], "unit": "score", "name": "DeltaBlue", "value": 353.0040020000002}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12696.20253164557], "unit": "score", "name": "Boyer", "value": 52.49309770687939}, {"lowerIsBetter": false, "replicates": [42872.34042553192], "unit": "score", "name": "RegExp", "value": 21.24878163771713}, {"lowerIsBetter": false, "replicates": [602.7727546714889], "unit": "score", "name": "Splay", "value": 135.19356900000005}, {"lowerIsBetter": false, "replicates": [4921.568627450981], "unit": "score", "name": "NavierStokes", "value": 301.52988047808736}], "name": "v8_7", "value": 20083.436264437234}]} 04:40:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20083.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1553.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6121.15"}}} 04:40:58 INFO - Return code: 0 04:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:40:58 INFO - # TBPL SUCCESS # 04:40:58 INFO - Running post-action listener: _resource_record_post_action 04:40:58 INFO - Running post-run listener: _resource_record_post_run 04:40:59 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 549920768; Read time: 0; Write time: 443552 04:40:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232312832; Read time: 0; Write time: 263844 04:40:59 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 317607936; Read time: 0; Write time: 179708 04:40:59 INFO - Running post-run listener: _upload_blobber_files 04:40:59 INFO - Blob upload gear active. 04:40:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:00 INFO - (blobuploader) - INFO - Done attempting. 04:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:01 INFO - (blobuploader) - INFO - Done attempting. 04:41:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:01 INFO - Return code: 0 04:41:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8912ad7d1ce167640256bb963abf9efbfbac8caef32143fb7d3fa5746fa6f4f7dcb55a842877d3a41f87a67fb1bf31d4aa67e3d6f3499858e87c133787cb07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/789c6f9918978e4cff4a150a5d77e0244b116b457784e5ea1cb68c2ab67bc59035834c61bdc409c1841e0d57c297847a2a32748d6a62b50b70c8aa1949b9434e"} 04:41:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:01 INFO - Contents: 04:41:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8912ad7d1ce167640256bb963abf9efbfbac8caef32143fb7d3fa5746fa6f4f7dcb55a842877d3a41f87a67fb1bf31d4aa67e3d6f3499858e87c133787cb07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/789c6f9918978e4cff4a150a5d77e0244b116b457784e5ea1cb68c2ab67bc59035834c61bdc409c1841e0d57c297847a2a32748d6a62b50b70c8aa1949b9434e"} 04:41:01 INFO - Copying logs to upload dir... 04:41:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1290.441489 ========= master_lag: 1.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-11 04:41:02.820433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 04:41:02.827899) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 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/f8912ad7d1ce167640256bb963abf9efbfbac8caef32143fb7d3fa5746fa6f4f7dcb55a842877d3a41f87a67fb1bf31d4aa67e3d6f3499858e87c133787cb07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/789c6f9918978e4cff4a150a5d77e0244b116b457784e5ea1cb68c2ab67bc59035834c61bdc409c1841e0d57c297847a2a32748d6a62b50b70c8aa1949b9434e"} build_url:https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/Fsi_NXPHS1Gr9eIGsZUzjA/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/f8912ad7d1ce167640256bb963abf9efbfbac8caef32143fb7d3fa5746fa6f4f7dcb55a842877d3a41f87a67fb1bf31d4aa67e3d6f3499858e87c133787cb07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/789c6f9918978e4cff4a150a5d77e0244b116b457784e5ea1cb68c2ab67bc59035834c61bdc409c1841e0d57c297847a2a32748d6a62b50b70c8aa1949b9434e"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 04:41:03.143861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:41:03.144176) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452512593.424411-1117047128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:41:03.160078) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 04:41:03.160346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 04:41:03.160619) ========= ========= Total master_lag: 2.08 =========