builder: date_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1457728753.15 results: success (0) buildid: 20160311100842 builduid: 692c1b1d85fe45bfa6a737efc7ffd8dd revision: 4668361a486d865c53a9ab683563a59b418c350a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.155369) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.156134) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.156464) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.189811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.190271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.213335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.213648) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.521209) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.521558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.521977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.522282) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 12:39:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.3M=0s 2016-03-11 12:39:14 (41.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151787 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.693763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.694075) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.746561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:13.746922) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 4668361a486d865c53a9ab683563a59b418c350a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 4668361a486d865c53a9ab683563a59b418c350a --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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 12:39:14,226 truncating revision to first 12 chars 2016-03-11 12:39:14,226 Setting DEBUG logging. 2016-03-11 12:39:14,226 attempt 1/10 2016-03-11 12:39:14,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/4668361a486d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 12:39:14,493 unpacking tar archive at: date-4668361a486d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:14.334327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:14.335285) ========= echo 4668361a486d865c53a9ab683563a59b418c350a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4668361a486d865c53a9ab683563a59b418c350a'] 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4668361a486d865c53a9ab683563a59b418c350a program finished with exit code 0 elapsedTime=0.004734 script_repo_revision: '4668361a486d865c53a9ab683563a59b418c350a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:14.392749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:14.393483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:14.405543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-11 12:39:14.405868) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-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', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:14 INFO - MultiFileLogger online at 20160311 12:39:14 in /builds/slave/test 12:39:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 12:39:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:14 INFO - {'append_to_log': False, 12:39:14 INFO - 'base_work_dir': '/builds/slave/test', 12:39:14 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:39:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:14 INFO - 'branch': 'Date-Non-PGO', 12:39:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:14 INFO - 'config_files': ('talos/linux_config.py',), 12:39:14 INFO - 'default_actions': ('clobber', 12:39:14 INFO - 'read-buildbot-config', 12:39:14 INFO - 'download-and-extract', 12:39:14 INFO - 'populate-webroot', 12:39:14 INFO - 'create-virtualenv', 12:39:14 INFO - 'install', 12:39:14 INFO - 'run-tests'), 12:39:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:14 INFO - 'download_minidump_stackwalk': True, 12:39:14 INFO - 'download_symbols': 'ondemand', 12:39:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:14 INFO - 'installer_path': 'installer.exe', 12:39:14 INFO - 'log_level': 'info', 12:39:14 INFO - 'log_name': 'talos', 12:39:14 INFO - 'log_to_console': True, 12:39:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:14 INFO - 'opt_config_files': (), 12:39:14 INFO - 'pip_index': False, 12:39:14 INFO - 'sps_profile': False, 12:39:14 INFO - 'sps_profile_interval': 0, 12:39:14 INFO - 'suite': 'dromaeojs-e10s', 12:39:14 INFO - 'system_bits': '32', 12:39:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:14 INFO - 'title': 'talos-linux64-ix-029', 12:39:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:14 INFO - 'use_talos_json': True, 12:39:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:14 INFO - 'work_dir': 'build'} 12:39:14 INFO - ##### 12:39:14 INFO - ##### Running clobber step. 12:39:14 INFO - ##### 12:39:14 INFO - Running pre-action listener: _resource_record_pre_action 12:39:14 INFO - Running main action method: clobber 12:39:14 INFO - rmtree: /builds/slave/test/build 12:39:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:15 INFO - Running post-action listener: _resource_record_post_action 12:39:15 INFO - ##### 12:39:15 INFO - ##### Running read-buildbot-config step. 12:39:15 INFO - ##### 12:39:15 INFO - Running pre-action listener: _resource_record_pre_action 12:39:15 INFO - Running main action method: read_buildbot_config 12:39:15 INFO - Using buildbot properties: 12:39:15 INFO - { 12:39:15 INFO - "project": "", 12:39:15 INFO - "product": "firefox", 12:39:15 INFO - "script_repo_revision": "production", 12:39:15 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs-e10s", 12:39:15 INFO - "repository": "", 12:39:15 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs-e10s", 12:39:15 INFO - "buildid": "20160311100842", 12:39:15 INFO - "pgo_build": "False", 12:39:15 INFO - "basedir": "/builds/slave/test", 12:39:15 INFO - "buildnumber": 2, 12:39:15 INFO - "slavename": "talos-linux64-ix-029", 12:39:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:39:15 INFO - "platform": "ubuntu64_hw", 12:39:15 INFO - "scheduler": "tests-date-linux64-talos", 12:39:15 INFO - "branch": "date", 12:39:15 INFO - "repo_path": "projects/date", 12:39:15 INFO - "revision": "4668361a486d865c53a9ab683563a59b418c350a", 12:39:15 INFO - "stage_platform": "linux64", 12:39:15 INFO - "builduid": "692c1b1d85fe45bfa6a737efc7ffd8dd", 12:39:15 INFO - "slavebuilddir": "test" 12:39:15 INFO - } 12:39:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:39:15 INFO - Running post-action listener: _resource_record_post_action 12:39:15 INFO - ##### 12:39:15 INFO - ##### Running download-and-extract step. 12:39:15 INFO - ##### 12:39:15 INFO - Running pre-action listener: _resource_record_pre_action 12:39:15 INFO - Running main action method: download_and_extract 12:39:15 INFO - mkdir: /builds/slave/test/build/tests 12:39:15 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')]} 12:39:15 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:39:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json 12:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json 12:39:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:39:20 INFO - Downloaded 1412 bytes. 12:39:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:39:20 INFO - Using the following test package requirements: 12:39:20 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:20 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:20 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:39:20 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'jsshell-linux-x86_64.zip'], 12:39:20 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:20 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:20 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:39:20 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:39:20 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:20 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:20 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:20 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:20 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:20 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:21 INFO - Downloaded 23091316 bytes. 12:39:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:23 INFO - Return code: 0 12:39:23 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:23 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:28 INFO - Downloaded 23091316 bytes. 12:39:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:29 INFO - Return code: 0 12:39:29 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')]} 12:39:29 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:39:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:39:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:39:31 INFO - Downloaded 10706668 bytes. 12:39:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:39:31 INFO - Return code: 0 12:39:31 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')]} 12:39:31 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:39:32 INFO - Downloaded 52858903 bytes. 12:39:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:32 INFO - mkdir: /builds/slave/test/properties 12:39:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:32 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:32 INFO - Contents: 12:39:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:33 INFO - Running post-action listener: _resource_record_post_action 12:39:33 INFO - Running post-action listener: set_extra_try_arguments 12:39:33 INFO - ##### 12:39:33 INFO - ##### Running populate-webroot step. 12:39:33 INFO - ##### 12:39:33 INFO - Running pre-action listener: _resource_record_pre_action 12:39:33 INFO - Running main action method: populate_webroot 12:39:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:33 INFO - '--tppagecycles', 12:39:33 INFO - '7'], 12:39:33 INFO - 'tests': ['tsvgm']}}, 12:39:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:39:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'tests': ['damp', 'tps']}, 12:39:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['damp', 'tps']}, 12:39:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:39:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:33 INFO - 'other': {'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'other_l64': {'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'other_nol64': {'tests': ['a11yr', 12:39:33 INFO - 'ts_paint', 12:39:33 INFO - 'tpaint', 12:39:33 INFO - 'sessionrestore', 12:39:33 INFO - 'sessionrestore_no_auto_restore']}, 12:39:33 INFO - 'svgr': {'tests': ['tsvgx', 12:39:33 INFO - 'tsvgr_opacity', 12:39:33 INFO - 'tart', 12:39:33 INFO - 'tscrollx', 12:39:33 INFO - 'cart']}, 12:39:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['tsvgx', 12:39:33 INFO - 'tsvgr_opacity', 12:39:33 INFO - 'tart', 12:39:33 INFO - 'tscrollx', 12:39:33 INFO - 'cart']}, 12:39:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'tests': ['tp5o']}, 12:39:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'talos_options': ['--e10s'], 12:39:33 INFO - 'tests': ['tp5o']}, 12:39:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'talos_options': ['--xperf_path', 12:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:33 INFO - 'tests': ['tp5n']}, 12:39:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:33 INFO - 'talos_options': ['--e10s', 12:39:33 INFO - '--xperf_path', 12:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:33 INFO - 'tests': ['tp5n']}}, 12:39:33 INFO - 'talos.zip': {'path': '', 12:39:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:33 INFO - Running post-action listener: _resource_record_post_action 12:39:33 INFO - ##### 12:39:33 INFO - ##### Running create-virtualenv step. 12:39:33 INFO - ##### 12:39:33 INFO - Running pre-action listener: _resource_record_pre_action 12:39:33 INFO - Running main action method: create_virtualenv 12:39:33 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:33 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 12:39:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:33 INFO - Using real prefix '/usr' 12:39:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:34 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:36 INFO - Installing pip.................done. 12:39:36 INFO - Return code: 0 12:39:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:36 INFO - Using env: {'DISPLAY': ':0', 12:39:36 INFO - 'HOME': '/home/cltbld', 12:39:36 INFO - 'LANG': 'en_US.UTF-8', 12:39:36 INFO - 'LANGUAGE': 'en_US:en', 12:39:36 INFO - 'LOGNAME': 'cltbld', 12:39:36 INFO - 'MAIL': '/var/mail/cltbld', 12:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:36 INFO - 'MOZ_NO_REMOTE': '1', 12:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:36 INFO - 'NO_EM_RESTART': '1', 12:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:36 INFO - 'PWD': '/builds/slave/test', 12:39:36 INFO - 'SHELL': '/bin/bash', 12:39:36 INFO - 'SHLVL': '1', 12:39:36 INFO - 'TERM': 'linux', 12:39:36 INFO - 'TMOUT': '86400', 12:39:36 INFO - 'USER': 'cltbld', 12:39:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:36 INFO - '_': '/tools/buildbot/bin/python'} 12:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:36 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 12:39:36 INFO - Cleaning up... 12:39:36 INFO - Return code: 0 12:39:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:36 INFO - Using env: {'DISPLAY': ':0', 12:39:36 INFO - 'HOME': '/home/cltbld', 12:39:36 INFO - 'LANG': 'en_US.UTF-8', 12:39:36 INFO - 'LANGUAGE': 'en_US:en', 12:39:36 INFO - 'LOGNAME': 'cltbld', 12:39:36 INFO - 'MAIL': '/var/mail/cltbld', 12:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:36 INFO - 'MOZ_NO_REMOTE': '1', 12:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:36 INFO - 'NO_EM_RESTART': '1', 12:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:36 INFO - 'PWD': '/builds/slave/test', 12:39:36 INFO - 'SHELL': '/bin/bash', 12:39:36 INFO - 'SHLVL': '1', 12:39:36 INFO - 'TERM': 'linux', 12:39:36 INFO - 'TMOUT': '86400', 12:39:36 INFO - 'USER': 'cltbld', 12:39:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:36 INFO - '_': '/tools/buildbot/bin/python'} 12:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:36 INFO - Downloading/unpacking psutil>=0.7.1 12:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:38 INFO - Installing collected packages: psutil 12:39:38 INFO - Running setup.py install for psutil 12:39:38 INFO - building 'psutil._psutil_linux' extension 12:39:38 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 12:39:38 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 12:39:38 INFO - building 'psutil._psutil_posix' extension 12:39:38 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 12:39:38 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 12:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:39 INFO - Successfully installed psutil 12:39:39 INFO - Cleaning up... 12:39:39 INFO - Return code: 0 12:39:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:39 INFO - Using env: {'DISPLAY': ':0', 12:39:39 INFO - 'HOME': '/home/cltbld', 12:39:39 INFO - 'LANG': 'en_US.UTF-8', 12:39:39 INFO - 'LANGUAGE': 'en_US:en', 12:39:39 INFO - 'LOGNAME': 'cltbld', 12:39:39 INFO - 'MAIL': '/var/mail/cltbld', 12:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:39 INFO - 'MOZ_NO_REMOTE': '1', 12:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:39 INFO - 'NO_EM_RESTART': '1', 12:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:39 INFO - 'PWD': '/builds/slave/test', 12:39:39 INFO - 'SHELL': '/bin/bash', 12:39:39 INFO - 'SHLVL': '1', 12:39:39 INFO - 'TERM': 'linux', 12:39:39 INFO - 'TMOUT': '86400', 12:39:39 INFO - 'USER': 'cltbld', 12:39:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:39 INFO - '_': '/tools/buildbot/bin/python'} 12:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39:39 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 12:39:39 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 12:39:39 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 12:39:39 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 12:39:39 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 12:39:39 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 12:39:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:39:41 INFO - Installing collected packages: mozsystemmonitor 12:39:41 INFO - Running setup.py install for mozsystemmonitor 12:39:41 INFO - Successfully installed mozsystemmonitor 12:39:41 INFO - Cleaning up... 12:39:41 INFO - Return code: 0 12:39:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:41 INFO - Using env: {'DISPLAY': ':0', 12:39:41 INFO - 'HOME': '/home/cltbld', 12:39:41 INFO - 'LANG': 'en_US.UTF-8', 12:39:41 INFO - 'LANGUAGE': 'en_US:en', 12:39:41 INFO - 'LOGNAME': 'cltbld', 12:39:41 INFO - 'MAIL': '/var/mail/cltbld', 12:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:41 INFO - 'MOZ_NO_REMOTE': '1', 12:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:41 INFO - 'NO_EM_RESTART': '1', 12:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:41 INFO - 'PWD': '/builds/slave/test', 12:39:41 INFO - 'SHELL': '/bin/bash', 12:39:41 INFO - 'SHLVL': '1', 12:39:41 INFO - 'TERM': 'linux', 12:39:41 INFO - 'TMOUT': '86400', 12:39:41 INFO - 'USER': 'cltbld', 12:39:41 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:41 INFO - '_': '/tools/buildbot/bin/python'} 12:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:39:41 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 12:39:41 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 12:39:41 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 12:39:41 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 12:39:41 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 12:39:41 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 12:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:39:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:43 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 12:39:44 INFO - Downloading docopt-0.6.1.tar.gz 12:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:39:44 INFO - Installing collected packages: blobuploader, requests, docopt 12:39:44 INFO - Running setup.py install for blobuploader 12:39:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:39:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:39:44 INFO - Running setup.py install for requests 12:39:44 INFO - Running setup.py install for docopt 12:39:44 INFO - Successfully installed blobuploader requests docopt 12:39:44 INFO - Cleaning up... 12:39:44 INFO - Return code: 0 12:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 12:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 12:39:44 INFO - Using env: {'DISPLAY': ':0', 12:39:44 INFO - 'HOME': '/home/cltbld', 12:39:44 INFO - 'LANG': 'en_US.UTF-8', 12:39:44 INFO - 'LANGUAGE': 'en_US:en', 12:39:44 INFO - 'LOGNAME': 'cltbld', 12:39:44 INFO - 'MAIL': '/var/mail/cltbld', 12:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:44 INFO - 'MOZ_NO_REMOTE': '1', 12:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:44 INFO - 'NO_EM_RESTART': '1', 12:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:44 INFO - 'PWD': '/builds/slave/test', 12:39:44 INFO - 'SHELL': '/bin/bash', 12:39:44 INFO - 'SHLVL': '1', 12:39:44 INFO - 'TERM': 'linux', 12:39:44 INFO - 'TMOUT': '86400', 12:39:44 INFO - 'USER': 'cltbld', 12:39:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:44 INFO - '_': '/tools/buildbot/bin/python'} 12:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:45 INFO - Running setup.py (path:/tmp/pip-Bfcc6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:45 INFO - Running setup.py (path:/tmp/pip-hQ5PQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:45 INFO - Running setup.py (path:/tmp/pip-8q6Kpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:45 INFO - Running setup.py (path:/tmp/pip-xYEh3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:45 INFO - Running setup.py (path:/tmp/pip-Qc_gRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:45 INFO - Running setup.py (path:/tmp/pip-D4Or5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:45 INFO - Running setup.py (path:/tmp/pip-Y5t8NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:45 INFO - Running setup.py (path:/tmp/pip-HDd0gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:45 INFO - Running setup.py (path:/tmp/pip-1zIwJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:45 INFO - Running setup.py (path:/tmp/pip-QHDDOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:45 INFO - Running setup.py (path:/tmp/pip-KDOAEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:45 INFO - Running setup.py (path:/tmp/pip-ZOgQ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:45 INFO - Running setup.py (path:/tmp/pip-ME63qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:45 INFO - Running setup.py (path:/tmp/pip-jOXwfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:46 INFO - Running setup.py (path:/tmp/pip-PnVlgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:46 INFO - Running setup.py (path:/tmp/pip-kq3IOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:46 INFO - Running setup.py (path:/tmp/pip-EdUkFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:39:46 INFO - Running setup.py install for manifestparser 12:39:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:39:46 INFO - Running setup.py install for mozcrash 12:39:46 INFO - Running setup.py install for mozdebug 12:39:46 INFO - Running setup.py install for mozdevice 12:39:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:39:46 INFO - Running setup.py install for mozfile 12:39:46 INFO - Running setup.py install for mozhttpd 12:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:39:46 INFO - Running setup.py install for mozinfo 12:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:39:46 INFO - Running setup.py install for mozInstall 12:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Running setup.py install for mozleak 12:39:47 INFO - Running setup.py install for mozlog 12:39:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Running setup.py install for moznetwork 12:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Running setup.py install for mozprocess 12:39:47 INFO - Running setup.py install for mozprofile 12:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Running setup.py install for mozrunner 12:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Running setup.py install for mozscreenshot 12:39:47 INFO - Running setup.py install for moztest 12:39:47 INFO - Running setup.py install for mozversion 12:39:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:39:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:47 INFO - Cleaning up... 12:39:47 INFO - Return code: 0 12:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:47 INFO - Using env: {'DISPLAY': ':0', 12:39:47 INFO - 'HOME': '/home/cltbld', 12:39:47 INFO - 'LANG': 'en_US.UTF-8', 12:39:47 INFO - 'LANGUAGE': 'en_US:en', 12:39:47 INFO - 'LOGNAME': 'cltbld', 12:39:47 INFO - 'MAIL': '/var/mail/cltbld', 12:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:47 INFO - 'MOZ_NO_REMOTE': '1', 12:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:47 INFO - 'NO_EM_RESTART': '1', 12:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:47 INFO - 'PWD': '/builds/slave/test', 12:39:47 INFO - 'SHELL': '/bin/bash', 12:39:47 INFO - 'SHLVL': '1', 12:39:47 INFO - 'TERM': 'linux', 12:39:47 INFO - 'TMOUT': '86400', 12:39:47 INFO - 'USER': 'cltbld', 12:39:47 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:48 INFO - '_': '/tools/buildbot/bin/python'} 12:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:48 INFO - Running setup.py (path:/tmp/pip-2pMS21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:48 INFO - Running setup.py (path:/tmp/pip-xIg7DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:48 INFO - Running setup.py (path:/tmp/pip-YaHNGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:48 INFO - Running setup.py (path:/tmp/pip-meqiZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:48 INFO - Running setup.py (path:/tmp/pip-r1QUxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:48 INFO - Running setup.py (path:/tmp/pip-i4e14j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:48 INFO - Running setup.py (path:/tmp/pip-IQcknK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:48 INFO - Running setup.py (path:/tmp/pip-BUgYv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:48 INFO - Running setup.py (path:/tmp/pip-tBGuIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:48 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)) 12:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:49 INFO - Running setup.py (path:/tmp/pip-8TCkcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:49 INFO - Running setup.py (path:/tmp/pip-kSk4PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:49 INFO - Running setup.py (path:/tmp/pip-52cvDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:49 INFO - Running setup.py (path:/tmp/pip-Ol3462-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:49 INFO - Running setup.py (path:/tmp/pip-tPw5uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:49 INFO - Running setup.py (path:/tmp/pip-UWIVeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:49 INFO - Running setup.py (path:/tmp/pip-lRzIko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:49 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)) 12:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:49 INFO - Running setup.py (path:/tmp/pip-Z7Mc51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:49 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)) 12:39:49 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)) 12:39:49 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)) 12:39:49 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)) 12:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:39:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:51 INFO - Downloading blessings-1.6.tar.gz 12:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:51 INFO - Installing collected packages: blessings 12:39:51 INFO - Running setup.py install for blessings 12:39:51 INFO - Successfully installed blessings 12:39:51 INFO - Cleaning up... 12:39:51 INFO - Return code: 0 12:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:51 INFO - Reading from file tmpfile_stdout 12:39:51 INFO - Current package versions: 12:39:51 INFO - argparse == 1.2.1 12:39:51 INFO - blessings == 1.6 12:39:51 INFO - blobuploader == 1.2.4 12:39:51 INFO - docopt == 0.6.1 12:39:51 INFO - manifestparser == 1.1 12:39:51 INFO - mozInstall == 1.12 12:39:51 INFO - mozcrash == 0.16 12:39:51 INFO - mozdebug == 0.1 12:39:51 INFO - mozdevice == 0.48 12:39:51 INFO - mozfile == 1.2 12:39:51 INFO - mozhttpd == 0.7 12:39:51 INFO - mozinfo == 0.9 12:39:51 INFO - mozleak == 0.1 12:39:51 INFO - mozlog == 3.1 12:39:51 INFO - moznetwork == 0.27 12:39:51 INFO - mozprocess == 0.22 12:39:51 INFO - mozprofile == 0.28 12:39:51 INFO - mozrunner == 6.11 12:39:51 INFO - mozscreenshot == 0.1 12:39:51 INFO - mozsystemmonitor == 0.0 12:39:51 INFO - moztest == 0.7 12:39:51 INFO - mozversion == 1.4 12:39:51 INFO - psutil == 3.1.1 12:39:51 INFO - requests == 1.2.3 12:39:51 INFO - wsgiref == 0.1.2 12:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:51 INFO - Using env: {'DISPLAY': ':0', 12:39:51 INFO - 'HOME': '/home/cltbld', 12:39:51 INFO - 'LANG': 'en_US.UTF-8', 12:39:51 INFO - 'LANGUAGE': 'en_US:en', 12:39:51 INFO - 'LOGNAME': 'cltbld', 12:39:51 INFO - 'MAIL': '/var/mail/cltbld', 12:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:51 INFO - 'MOZ_NO_REMOTE': '1', 12:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:51 INFO - 'NO_EM_RESTART': '1', 12:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:51 INFO - 'PWD': '/builds/slave/test', 12:39:51 INFO - 'SHELL': '/bin/bash', 12:39:51 INFO - 'SHLVL': '1', 12:39:51 INFO - 'TERM': 'linux', 12:39:51 INFO - 'TMOUT': '86400', 12:39:51 INFO - 'USER': 'cltbld', 12:39:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:51 INFO - '_': '/tools/buildbot/bin/python'} 12:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 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)) 12:39:52 INFO - Cleaning up... 12:39:52 INFO - Return code: 0 12:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:52 INFO - Using env: {'DISPLAY': ':0', 12:39:52 INFO - 'HOME': '/home/cltbld', 12:39:52 INFO - 'LANG': 'en_US.UTF-8', 12:39:52 INFO - 'LANGUAGE': 'en_US:en', 12:39:52 INFO - 'LOGNAME': 'cltbld', 12:39:52 INFO - 'MAIL': '/var/mail/cltbld', 12:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:52 INFO - 'MOZ_NO_REMOTE': '1', 12:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:52 INFO - 'NO_EM_RESTART': '1', 12:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:52 INFO - 'PWD': '/builds/slave/test', 12:39:52 INFO - 'SHELL': '/bin/bash', 12:39:52 INFO - 'SHLVL': '1', 12:39:52 INFO - 'TERM': 'linux', 12:39:52 INFO - 'TMOUT': '86400', 12:39:52 INFO - 'USER': 'cltbld', 12:39:52 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:52 INFO - '_': '/tools/buildbot/bin/python'} 12:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:52 INFO - Downloading/unpacking jsonschema 12:39:52 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 12:39:52 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 12:39:52 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 12:39:52 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 12:39:52 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 12:39:52 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 12:39:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:54 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:54 INFO - warning: no files found matching '*.txt' 12:39:54 INFO - no previously-included directories found matching 'build' 12:39:54 INFO - no previously-included directories found matching 'dist' 12:39:54 INFO - no previously-included directories found matching '.git*' 12:39:54 INFO - Installing collected packages: jsonschema, functools32 12:39:54 INFO - Running setup.py install for functools32 12:39:54 INFO - warning: no files found matching '*.txt' 12:39:54 INFO - no previously-included directories found matching 'build' 12:39:54 INFO - no previously-included directories found matching 'dist' 12:39:54 INFO - no previously-included directories found matching '.git*' 12:39:54 INFO - Successfully installed jsonschema functools32 12:39:54 INFO - Cleaning up... 12:39:54 INFO - Return code: 0 12:39:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f760d61ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c0e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, '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': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', '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 12:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:39:54 INFO - Using env: {'DISPLAY': ':0', 12:39:54 INFO - 'HOME': '/home/cltbld', 12:39:54 INFO - 'LANG': 'en_US.UTF-8', 12:39:54 INFO - 'LANGUAGE': 'en_US:en', 12:39:54 INFO - 'LOGNAME': 'cltbld', 12:39:54 INFO - 'MAIL': '/var/mail/cltbld', 12:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:54 INFO - 'MOZ_NO_REMOTE': '1', 12:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:54 INFO - 'NO_EM_RESTART': '1', 12:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:54 INFO - 'PWD': '/builds/slave/test', 12:39:54 INFO - 'SHELL': '/bin/bash', 12:39:54 INFO - 'SHLVL': '1', 12:39:54 INFO - 'TERM': 'linux', 12:39:54 INFO - 'TMOUT': '86400', 12:39:54 INFO - 'USER': 'cltbld', 12:39:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:54 INFO - '_': '/tools/buildbot/bin/python'} 12:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:54 INFO - Downloading/unpacking flake8 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:57 INFO - no previously-included directories found matching 'docs/_build' 12:39:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:57 INFO - Running setup.py install for pep8 12:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:57 INFO - no previously-included directories found matching 'docs/_build' 12:39:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:39:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:57 INFO - Cleaning up... 12:39:57 INFO - Return code: 0 12:39:57 INFO - Running post-action listener: _resource_record_post_action 12:39:57 INFO - Running post-action listener: _start_resource_monitoring 12:39:57 INFO - Starting resource monitoring. 12:39:57 INFO - ##### 12:39:57 INFO - ##### Running install step. 12:39:57 INFO - ##### 12:39:57 INFO - Running pre-action listener: _resource_record_pre_action 12:39:57 INFO - Running main action method: install 12:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:57 INFO - Reading from file tmpfile_stdout 12:39:57 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:39:57 INFO - Reading from file tmpfile_stdout 12:39:57 INFO - Output received: 12:39:57 INFO - Usage: mozinstall [options] installer 12:39:57 INFO - Options: 12:39:57 INFO - -h, --help show this help message and exit 12:39:57 INFO - -d DEST, --destination=DEST 12:39:57 INFO - Directory to install application into. [default: 12:39:57 INFO - "/builds/slave/test"] 12:39:57 INFO - --app=APP Application being installed. [default: firefox] 12:39:57 INFO - mkdir: /builds/slave/test/build/application 12:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:40:10 INFO - Reading from file tmpfile_stdout 12:40:10 INFO - Output received: 12:40:10 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:10 INFO - Running post-action listener: _resource_record_post_action 12:40:10 INFO - ##### 12:40:10 INFO - ##### Running run-tests step. 12:40:10 INFO - ##### 12:40:10 INFO - Running pre-action listener: _resource_record_pre_action 12:40:10 INFO - Running main action method: run_tests 12:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:10 INFO - Python 2.7.3 12:40:10 INFO - Return code: 0 12:40:10 INFO - grabbing minidump binary from tooltool 12:40: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')]} 12:40:10 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 0x2753430>, '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 0x26bef30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bf3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:10 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 12:40:10 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 12:40:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:10 INFO - Return code: 0 12:40:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:11 INFO - Return code: 0 12:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 12:40:11 INFO - Using env: {'DISPLAY': ':0', 12:40:11 INFO - 'HOME': '/home/cltbld', 12:40:11 INFO - 'LANG': 'en_US.UTF-8', 12:40:11 INFO - 'LANGUAGE': 'en_US:en', 12:40:11 INFO - 'LOGNAME': 'cltbld', 12:40:11 INFO - 'MAIL': '/var/mail/cltbld', 12:40:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:11 INFO - 'MOZ_NO_REMOTE': '1', 12:40:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:11 INFO - 'NO_EM_RESTART': '1', 12:40:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:11 INFO - 'PWD': '/builds/slave/test', 12:40:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:11 INFO - 'SHELL': '/bin/bash', 12:40:11 INFO - 'SHLVL': '1', 12:40:11 INFO - 'TERM': 'linux', 12:40:11 INFO - 'TMOUT': '86400', 12:40:11 INFO - 'USER': 'cltbld', 12:40:11 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985', 12:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:11 INFO - '_': '/tools/buildbot/bin/python'} 12:40:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:40:11 INFO - mozversion application_buildid: 20160311100842 12:40:11 INFO - mozversion application_changeset: 4668361a486d865c53a9ab683563a59b418c350a 12:40:11 INFO - mozversion application_display_name: Firefox 12:40:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:11 INFO - mozversion application_name: Firefox 12:40:11 INFO - mozversion application_remotingname: firefox 12:40:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:40:11 INFO - mozversion application_vendor: Mozilla 12:40:11 INFO - mozversion application_version: 46.0 12:40:11 INFO - mozversion platform_buildid: 20160311100842 12:40:11 INFO - mozversion platform_changeset: 4668361a486d865c53a9ab683563a59b418c350a 12:40:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:40:11 INFO - mozversion platform_version: 46.0 12:40:11 INFO - using testdate: 1457728811 12:40:11 INFO - actual date: 1457728811 12:40:11 INFO - starting webserver on 'localhost:55685' 12:40:11 INFO - SUITE-START | Running 3 tests 12:40:11 INFO - TEST-START | dromaeo_css 12:40:11 INFO - operating with platform_type : linux_ 12:40:11 INFO - Initialising browser for dromaeo_css test... 12:40:11 INFO - TEST-INFO | started process 11772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJB3_N/profile http://localhost:55685/getInfo.html) 12:40:15 INFO - PROCESS | 11772 | 12:40:15 INFO - PROCESS | 11772 | (process:11849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:40:16 INFO - PROCESS | 11772 | __metrics Screen width/height:1600/1200 12:40:16 INFO - PROCESS | 11772 | colorDepth:24 12:40:16 INFO - PROCESS | 11772 | Browser inner width/height: 1024/697 12:40:16 INFO - PROCESS | 11772 | __metrics 12:40:16 INFO - TEST-INFO | 11772: exit 0 12:40:16 INFO - Browser initialized. 12:40:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:16 INFO - TEST-INFO | started process 11897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJB3_N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:18 INFO - PROCESS | 11897 | 12:40:18 INFO - PROCESS | 11897 | (process:11961): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:40:28 INFO - PROCESS | 11897 | RSS: Main: 139870208 12:40:28 INFO - PROCESS | 11897 | 12:41:18 INFO - PROCESS | 11897 | 1457728878307 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] 12:43:26 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55685/tests/dromaeo/cssquery-ext.html) 12:43:27 INFO - PROCESS | 11897 | RSS: Main: 143339520 12:43:27 INFO - PROCESS | 11897 | 12:46:29 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-ext.html (next: http://localhost:55685/tests/dromaeo/cssquery-jquery.html) 12:46:29 INFO - PROCESS | 11897 | RSS: Main: 141312000 12:46:29 INFO - PROCESS | 11897 | 12:49:31 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55685/tests/dromaeo/cssquery-mootools.html) 12:49:32 INFO - PROCESS | 11897 | RSS: Main: 141705216 12:49:32 INFO - PROCESS | 11897 | 12:52:33 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55685/tests/dromaeo/cssquery-prototype.html) 12:52:34 INFO - PROCESS | 11897 | RSS: Main: 142082048 12:52:34 INFO - PROCESS | 11897 | 12:55:36 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55685/tests/dromaeo/cssquery-yui.html) 12:55:37 INFO - PROCESS | 11897 | RSS: Main: 141877248 12:55:37 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | Cycle 1(1): loaded http://localhost:55685/tests/dromaeo/cssquery-yui.html (next: http://localhost:55685/tests/dromaeo/cssquery-dojo.html) 12:58:39 INFO - PROCESS | 11897 | RSS: Main: 144232448 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | __start_tp_report 12:58:39 INFO - PROCESS | 11897 | _x_x_mozilla_page_load 12:58:39 INFO - PROCESS | 11897 | _x_x_mozilla_page_load_details 12:58:39 INFO - PROCESS | 11897 | |i|pagename|runs| 12:58:39 INFO - PROCESS | 11897 | |0;dojo.html;3368.983155084226;3380.34083353746;3383.813890236036;3398.048546407007;3407.539982102417;5470.5350045246205;5479.232907392963;5488.807891723791;5489.615726899118;5495.230667706524;5411.269478620385;5467.863303417416;5497.422770609089;5501.724913754317;5550.833474995757;4972.651914365987;5029.698218106907;5095.770690318945;5110.361204849394;5156.819511317105;4913.926291105637;5069.340985671857;5073.162928116856;5082.161443361841;5167.534921857032;5184.766685499143;5185.662931909433;5223.373195216579;5229.163333866582;5229.37247530295;5156.329677141966;5157.871053223662;5181.4300426953005;5198.454162312941;5202.557782588485;4969.701817890938;5018.698878067327;5033.0688822567945;5081.3140226069745;5103.18349064148;5369.9463005369835;5379.704116273603;5413.242146099549;5431.212474191259;5434.266374039533;5971.581989260753;6043.214382130295;6062.848428789272;6070;6083.209182806251;5850.619709718854;5877.441643043904;5925.703714814285;6022.819315420545;6046.27444706638;5686.232358631573;5694.060480020833;5717.085266357404;5717.313922329347;5734.655920644775;6177.382261773877;6210.782622608277;6211.378862113753;6213.65824879627;6214.627122372672;5691.658500489983;5771.249737534094;5842.737076831553;5913.438223368773;5948.762049518057;5958.523318134538;5959.046552551571;5961.672108034013;5962.612430192024;5975.043992961192;5810.4189581041555;5896.1450589664255;5949.375315591887;5953.613015154001;5979.222701048836;5866.090755932837;5898.705064746746;5937;6003.859266739393;6050.364711705296;4530.22986092365;4539.455265368177;4557.043020965568;4567.977160114245;4578.771061446981;4025.376066709665;4115.135821477524;4122.732022418533;4127.711060225755;4134.441850350164;5600.943990560124;5604.551635869121;5618.297712785902;5683;5721.5136713379825;6024.246969128859;6030.939690603125;6039.396060394013;6041.6375017499095;6047.818565443044;5528.115501519737;5699.715014249354;5716.628419152742;5732.254806875163;5736.254286942671;5021.5229553192385;5065.797368105308;5092.719900405439;5108.591312694975;5147.97426012875;6069.696515174312;6081.787137450168;6097.939020609737;6102.72537735803;6180.81457556274;5860.413958604106;5955.940440595712;5956.970215148896;5981.342052374148;6010.128531363015;6150.138980542817;6167.629942203482;6173.81478555644;6185.690715464299;6190.597611155261;5923.170756094064;5934.9406505934385;5936.525077993837;5947.762089516544;5984.760609575568;5824.883502329845;5914;6015.037593984942;6021.849453763691;6049.939500605114;5863.091220860773;5867.882642347044;5880.8235752927485;5900.616459930091;5910.1725758392995;5857.648541087548;5864.472197502245;5876.206712093813;5879.794207202727;5881.94118058831;5645.774169033192;5725.713714314351;5732.684702341411;5792.565557583114;5793.131030345482;5898.528117750656;5939.703014849154;5964.582479226413;5994.700264986646;5997.970010149921;5799.159121927381;5802.0426629605645;5835.153902684002;5840.561957853093;5841.4450627190345 12:58:39 INFO - PROCESS | 11897 | |1;ext.html;537.6962016460697;541.1530954056904;551.8510002299378;574.7471112710407;584.2550747796558;29751.404971900574;39672.40491392628;39693.206135877335;39782.40326395106;39862.402063969064;41950.16099678005;42260.15479690404;42396.576034239646;42457.15085698292;42635.78682106593;8585.441946273488;8818.07410221924;8826;8890.288776897833;8893.377463577552;8482.957585212096;8597.054324024351;8669.523176225304;8677.869831952527;8870.334724895627;8872.512011839346;8902.910970890305;8927.241184499326;8953.641854325819;8965.506897120657;8845.95577022114;8886.600102995317;8907.421017633866;8918.866217006751;8921.973972993092;8837.779055523599;8869.778255543599;8925.062868398789;8926.509042002688;8953.462792232487;43043.35434968478;43312.78343608294;43516.78241608771;43561;43597;3690.280395322913;3842.5965273646143;3873.0511024799102;4033.4151548025666;4162.958370416318;32789.19659418731;32913.506297405555;33029.6697033029;33471;33950.1512462188;4276.273033584298;4323.7405755654445;4341.39220509129;4407.691461597689;4410.206162890679;282330;282638;282705;284198;285102;64503;64587;64802;64817.67591162014;64850.35149648443;68361;68610.65694671594;68645.65677171582;68720;68751.3124868755;15245.771313430307;15743.763843542356;15786.21068946548;15805.209739512979;15821.446249381446;11748.118891083202;11907.404629768476;11908.225965312227;11958.282503049844;11964.88035119655;22280.220192293516;22396.55206895853;22451.101955921582;22596.774032259797;22599.661005084938;7575.356094731899;7789.922100779033;7850;7852.685892564347;7976.561289129154;869.5608717597572;958.5973890965672;960.2653969713175;989.9455529945922;1109.8446217529552;28326.71673283282;29607.407851842843;30627.833136968817;32687.83656081752;33079.83460082732;1113.471101226927;1124.9887501124883;1195.2708847602955;1222.4376786678229;1248.581725122076;14568.562943111723;14822.777658335133;14844.406223751144;15065.09609423438;15085.24573771307;377814;381624;382038;506517;514303;48270.27594586084;48566.75716621465;48627.27059094117;48679.513204868206;48821.26768098481;1447.7755947828105;1448.2251995182737;1448.6957738874955;1448.898577099593;1450.354592206479;28854.42291154123;28936.565951511166;29194.56208156922;29547.85226073856;29750.702492974793;47394.52605474039;47538.28692569683;47826;47856.76071619619;47953.28070078882;267751;268022;269106;270295;270763;34954;35207.82396088003;35491.645083548836;35675.28649427049;35724.46413303751;46194;46552.7672361636;46717.53282467132;47541.762291189705;47964.7601761989;39960.40059399053;40020.993701888736;40103;40786.79606601948;41152.794236028625;39846;39984.00039999023;40171;40354;40565.79717101514;39092.804535977135;39190;39552.40671389874;39569.208615826945;39592.40611390889;34799.4780078294;35080.482043240096;35259.29481410409;35655.28689426249;35757.82121089378;26927.86536067307;27286.04498842531;27342.589861152497;27372.315692107855;28855.85572072126 12:58:39 INFO - PROCESS | 11897 | |2;jquery.html;379.27369088196104;379.65261785466294;380.9200067985723;381.41833703602003;386.37407400011983;15778.211089445525;17274;17948.19233134509;18004.909975450137;18042.368517101902;15577.065376077415;16282;16575.419860304894;16936;17034.23345949432;4883.853484395474;5016.623753218505;5026.698398096126;5034.320366750497;5036.773345199456;4864.610831133501;4981.950180498203;4987.800487980477;5024.723640199788;5063.164577844651;4978.278149668296;5014.022265658198;5017;5145.099607568679;5353.946460535403;5301.920471192935;5307.124324486455;5340.06548853951;5348.331458567679;5367.973160134175;5339.733013349317;5349.652272602308;5354.464553544653;5391.406945236021;5405.702686352249;12951.48194072236;19279.710804337945;20441.897790510953;21271.0428030739;21460.57078858414;2188.8686678799163;2203.5813195492806;2232.1852523828848;2263.977360226393;2412.9034838606435;9988.924372836438;10218.386896786216;11718.945294923498;12031.27812331263;13220.603381898462;1884.5100273928877;1963.3226536844766;1967.1836187982112;1996.3711430899366;2000.2798992362739;59267.70366148185;59279;60522.39477605212;60803.39196608021;61019.69490152521;10648.574057037787;10878.292910960763;10938.617148399768;10998.835017474745;11067.667969960914;14311.499097531745;14322;14420.783688244685;14509.984301098822;14568.34442450071;7370.226126256773;7413.962930185315;7466.738664146729;7482.663280152297;7510.6620202091035;6902.550464402431;6902.6203558803745;6903.033575299462;6904.551204171713;6966.686499107553;4615.284630882219;4719.174144524694;4723.338732577442;4766.594839438687;4784.354112194878;1888.4901076709211;1938.932137375185;2010.8391328693963;2014.74815648044;2041.6018876319272;466.48686444911004;941.7975135345933;1001.5593139018808;1067.5409573883305;1109.9056580190775;10705.250632455809;11242.100631949424;11300.660980170607;11412.771744565061;11477.655670329903;481.4559547711064;500.7020822610541;501.3958180392618;502.7436007636132;503.82869824259194;6022.488088512438;6144.969275153596;6254.437100660963;6270;6293.748250070037;567678;568725;586089;596117;622254;76216;77134.22865771383;77308;78618.6069069651;79840.20159798444;515.2065818639328;518.3546484626588;519.22894501665;519.7271432497969;520.8515573061659;10358.792824143324;10473.738156546147;10574.15406767472;10590.523426445983;10802.081823044815;32348.514772277966;32910.17724556809;33636.831815840764;33720.662793371754;34332.31335373328;47053.29420058634;47939.520604793506;48126.75936620295;48186.759066204446;50502.494975051246;7597.6581053853815;7687.500312479671;7700.884486732815;7730.652120654697;8034.51792892405;10409.47952602382;11285.21003529745;11517.712057198638;11638;11850.8156178962;9449.48027858447;9625.614975400906;9703.563339649874;9991.550380233053;10525.789484210427;9381.437113773196;9606.711798646053;9613;10130;10457.68626941193;9473.57368918414;9596.472194029395;10081.596736130472;10136;10250.692479225636;7904.367650587824;8094.757157285291;8108.189181081844;8146.2261085196815;8161.224683655043;10100.44447555362;10735.570577177137;10897.782044359226;10917.672469825919;10929.56281748721 12:58:39 INFO - PROCESS | 11897 | |3;mootools.html;1392.053403685494;1427.90004699671;1564.6557757293392;1702.4296860551715;1763.8765286429955;7765.767026989185;7933.127355990837;8004.999999999993;8211.384146189044;8419.452735572184;8191.91808081919;8196.344292456604;8234.547099909503;8238.835223295531;8242.587870606476;2382.9523409531844;2412.4692567635093;2414.263649586884;2417.0815090265764;2418.746031666676;2425.672534207877;2426.211481268586;2491.0907518755703;2492.1152990688224;2492.763187497185;2282.7260728712495;2345.777151170636;2362.185046159081;2439.42673471734;2464.3223113643803;2426.514697060586;2451.4116612013167;2455.2879664897246;2459.5449841779327;2462.852228866274;2402.3753824005707;2413.1312727418117;2424.7211570669424;2426.963595546068;2435.695538057743;8009.319207867338;8026.478278911852;8032.1164671886045;8033.397495187826;8052.19478052196;4941.777620007108;4960.156773348539;5024.723640199788;5066.620003499752;5192.273081768555;3262.4943133814295;3312.387208366436;3314.4034073866696;3322.0200040987966;3326.3679900818765;1077.4720387010386;1089.2810744908322;1094.7536804219067;1119.748056687247;1133.7732453509332;11648.359340236284;11686.298822070617;11707.239029463057;11713.472893719803;11812.114091443176;4529.5243999380245;4534.659900507475;4550.998780268335;4573.3368661544555;4579.22153233951;9491.620335186653;9495.715128546155;9496.762580935532;9509.524523773784;9519.095685909828;5110;5112.258722485219;5121.129408000649;5145.099607568661;5145.562627176657;4482.439695038121;4534.773261336986;4551.681382303207;4596.908061838744;4624.838130665411;3830.7701537907815;3842.4620553122586;3869.59369266223;3892.4355968384994;3900.258950799339;1127.622246547416;1148.3856136966683;1171.244547267008;1175.7766024455327;1198.6284251881943;1443.5741456270425;1450.4923276853017;1450.5430789301336;1470.5735336752437;1483.8664520193233;7637.274458926393;7716.2283771623515;7717.845643087219;7721.305082542486;7721.806954826062;1181.1908842442954;1197.3175290084741;1200.5557943560939;1211.1521934645784;1212.751385965875;5854.677992710356;5944.464998150187;5987.101934709828;6013.6993150342305;6053.848653783691;9450.43297402158;9608.9039109608;9668;9751.463669498246;9769.218462522982;9282.62869485213;9493.288003399774;9516.23870090391;9549.188318992825;9561.665341713007;7599.392048636207;7686.846263074819;7695.538267703956;7736.071671399468;7736.497127686683;8074.919250807417;8080.191980801873;8083.434159608771;8145.633446494803;8156.347492200728;9039.774005649911;9055.728328150166;9078.182963533314;9164.358494905293;9252.306077044113;8826.205641492297;9051.773705657411;9284.30367722437;9333.113354231336;9468.053194680477;7194.71221151169;7338.70645174187;7340.412766978736;7352.603005428951;7373.225811289952;7813.413993950363;7829.530228186327;7907;7913.485623434458;7923.960380198293;7420.03539539878;7450.813729656802;7545.207753186056;7577.431692622965;7662.770116896502;7366.152892417441;7374.078240219973;7417.36952359034;7432.591207483641;7458.216887226763;7492.737754178577;7499.550026998179;7570.810729731801;7592.544447333178;7601.923980760122;6798.558093723892;6882.621455819978;6895.4138898192205;6901.861962760817;6926.376626103674;6928.237893831775;7018.859622807618;7096.148462184571;7098.3256590623805;7135.464840137114 12:58:39 INFO - PROCESS | 11897 | |4;prototype.html;358.55539131476974;365.6106246847107;366.66450198068765;373.40628400842655;373.8336440284075;6439.742410303582;6456.774012909549;6486.902696459557;6526.543141980063;6528.34716528347;6322.304546499881;6400.743970241185;6442.130312407823;6488.80533583992;6504.902426463606;4918.0901533216465;4922.163232250526;4928.285398617199;4942.505749425065;4942.901141977176;4888.486708895568;4894.608431325485;4901.754912254391;4902.534259245366;4951.059298733229;4464.910701785962;4791.329213910055;4836.854894353175;4854.150523658363;4866.3673722416215;4830.468648448686;4839.4434640016325;4840.346553215341;4846.975765121169;4874.731889746063;4198.5591512891315;4215.346621273708;4216.9156616867795;4224.38746381776;4230.725002874834;5986.2517185351835;6145.477634401082;6158.784442544489;6172.660503672296;6176.87646247077;5743.770249190027;5757.942420575782;5767.8558036049435;5785.074388097884;5786.1610066540115;6912.101426814482;6935.549189302729;6938.444924406035;6944.756933507303;6961.721531138748;4752.952470475286;4755.2153894607345;4756.357891684613;4756.833510827105;4784.904301913977;6957.408620267283;7139.643017849086;7168.856622867565;7181.138263408372;7191.856162876713;4850.369451971221;4850.684705494132;4853.126437241331;4862.1005114053305;4866.221404575251;4887.584555312838;4919.458859525449;4921.729304888266;4929.0388374267395;4933.901321973541;5547.611667183259;5716.657000579979;5732.856678582985;5734.197212390269;5743.10981797822;6906.654667266616;6946.756863509753;6948.270431604608;6956.617386043715;6965.094537710065;1640.3520609359236;1677.639307548883;1677.9077150756825;1705.976414151499;1712.5889786451162;1121.1927412263158;1132.252713209278;1134.5405110930087;1135.8523391958993;1147.6155487911642;6630.204375474974;6651.700673469705;6655.068290439245;6658.4673226141795;6659.9001014984815;7062.71749130029;7102.254263302279;7106.964465177641;7109.075820143452;7111.2533184015965;6535.411812936859;6624.238212605515;6630.900536491957;6642.7342906284175;6657.500687448461;3815.4849095372324;3838.8848334550007;3848.0572259796527;3855.2674991752037;3856.8842934712;7263.4915555910575;7309.159446663702;7309.561426314438;7314;7323.7436689715605;7108.537945033556;7281.927180728125;7288.234735352818;7290.234525374759;7431.368333691588;7424.628768561551;7458.216887226871;7476.289752473506;7484.738034168778;7484.775456736306;7178.28217178278;7220.3140701633265;7239.203687594466;7241.312075352833;7254.709811607477;6948.756793512202;7114.181869085121;7126.322999315057;7151.177614574391;7153.284671532805;7441.218672039358;7446.069241344832;7459.142198647008;7471.962640186982;7492.51298665585;4827.300041493893;4862.708237505761;4885.65800393969;4895.388076490439;4920.827771027997;6999.265077166824;7081.575105493687;7113.288671132846;7190.640467976685;7203.099612548432;6945.062416573698;6994.790156295319;7023.929760702327;7025.824354391181;7031.22656507794;7047.083879095685;7051.471139664443;7052.400545953651;7056.435485161072;7059.82350441243;6645.833854153491;6841.760538381132;6873.965630171817;6876.896846547205;6891.104156459829;7008.719651213894;7011.6494175292055;7013.509054366145;7021.262767409348;7022.157341119098;6706.798796036127;6844.281350458329;6845.247022827385;6850.623215723183;6854.280300568368 12:58:39 INFO - PROCESS | 11897 | |5;yui.html;797.4856217739556;820.4953953318707;864.9048604653487;914.6432891172448;933.523902809567;14794.112353258799;14915.627109322273;14998.77501837472;15028;15035.84964150361;12894.355282235898;13020.609381718563;13648.72702545951;13661.65845853854;13689.17864928105;880.5861245214738;897.3673560140086;897.4974014551839;900.2213085680871;900.9594568244445;893.3255392178896;895.7447127568644;895.8387490251752;897.1208215948375;898.8382091223577;930.186087173723;932.202966463674;933.3280038372361;933.8319102561536;934.9906500935006;928.4800511713428;929.6235024814927;932.1098351074742;932.6502561539422;933.3046880074388;682.4608559238196;684.6063513479769;687.3126873126873;690.2614202803003;691.0705101638289;13124.540641077516;13159.07886447949;13204.405801738945;13206;13217.801732974012;11926.761464770656;12030.69923251917;12117.697057573543;12190.146689731722;12590.559330423483;9802.117809397188;9890.060444257784;10242.53908574116;10282.12601928837;10615.46922653872;3650.7992060436663;3767.472553842464;3796.0699628590896;3821.3503704370323;3837.520309961255;44971.77514112441;45434.31848522275;48868.755656221845;49655.50344496545;52023.47976520224;10149.137323327452;10378.323363450883;10511.1591072714;10569.109736618158;10586.89413105859;17477.126143692763;17488;17500.737488937677;17512.21195046226;17546.38587649426;8121.187881211831;8154.714584989615;8174;8304.8339033219;8394.90866187404;4392.2094023075515;4401.053773438726;4407.823687052546;4526.524714904954;4680.625549956064;3264.2002709336366;3275.263065810221;3293.1602441377295;3294.3081952789703;3300.1254667513126;588.205922005298;602.3374288282854;603.7675494934482;607.8298076538576;608.5496732417979;666.9466442684574;675.9256481786999;676.6379986707088;699.5208282326622;721.974730884427;9498.477583732962;9567.665131720356;9715.36850104741;9755.560999755027;9864.161546268504;578.9797357092482;661.3716968879584;663.8838203314401;687.5599616245606;692.4010730717994;4037;4097.651699605567;4145.108801607608;4148.838325268869;4196.118815048813;61130.38869611336;61817.38182618206;62133;62186.37813621896;62338.37661623416;51510.74244628753;54245;54467.45532544624;55059.44940550623;55518.72240638771;46038.309425358646;46080.5391946083;46496;46900.530994690984;46959.5304046962;9492.098250666175;9662;9841.557129929313;9920.603175872884;10048.598056077675;35473.645263547034;36255.81872090622;36374.63625363712;36684;36795;45524;46991.295130572384;47259.76370118128;48648.2702759466;49034.75482622564;12235.816462752888;12287.75424491523;12364;12517.436715348013;12542.623721288375;13395.062345635712;13445.932770336085;13601.727965440437;13717.382717777524;13754.243516606683;12259.38703064861;12559.058070644556;12795.040371971952;13003.349832508526;13186.472541098248;12681.80977285323;12688.809667854805;12889.8066529004;13186.076974611686;13275.40260688252;11568.595099171489;11617.186796924134;11660.825087623523;11854.170208085352;12015.639530814089;8825.867611985954;9041.59312830911;9180.403273787182;9305.720828375159;9312.534373281444;8581.570921454027;8684.478931264144;8789.664844828167;8861.113888611346;8882.467051976902 12:58:39 INFO - PROCESS | 11897 | __end_tp_report 12:58:39 INFO - PROCESS | 11897 | __start_cc_report 12:58:39 INFO - PROCESS | 11897 | _x_x_mozilla_cycle_collect,259 12:58:39 INFO - PROCESS | 11897 | __end_cc_report 12:58:39 INFO - PROCESS | 11897 | __startTimestamp1457729919454__endTimestamp 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | ------- Summary: start ------- 12:58:39 INFO - PROCESS | 11897 | Number of tests: 6 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#0] dojo.html Cycles:165 Average:5558.62 Median:5799.16 stddev:614.73 (10.6%) stddev-sans-first:592.13 12:58:39 INFO - PROCESS | 11897 | Values: 3369.0 3380.3 3383.8 3398.0 3407.5 5470.5 5479.2 5488.8 5489.6 5495.2 5411.3 5467.9 5497.4 5501.7 5550.8 4972.7 5029.7 5095.8 5110.4 5156.8 4913.9 5069.3 5073.2 5082.2 5167.5 5184.8 5185.7 5223.4 5229.2 5229.4 5156.3 5157.9 5181.4 5198.5 5202.6 4969.7 5018.7 5033.1 5081.3 5103.2 5369.9 5379.7 5413.2 5431.2 5434.3 5971.6 6043.2 6062.8 6070.0 6083.2 5850.6 5877.4 5925.7 6022.8 6046.3 5686.2 5694.1 5717.1 5717.3 5734.7 6177.4 6210.8 6211.4 6213.7 6214.6 5691.7 5771.2 5842.7 5913.4 5948.8 5958.5 5959.0 5961.7 5962.6 5975.0 5810.4 5896.1 5949.4 5953.6 5979.2 5866.1 5898.7 5937.0 6003.9 6050.4 4530.2 4539.5 4557.0 4568.0 4578.8 4025.4 4115.1 4122.7 4127.7 4134.4 5600.9 5604.6 5618.3 5683.0 5721.5 6024.2 6030.9 6039.4 6041.6 6047.8 5528.1 5699.7 5716.6 5732.3 5736.3 5021.5 5065.8 5092.7 5108.6 5148.0 6069.7 6081.8 6097.9 6102.7 6180.8 5860.4 5955.9 5957.0 5981.3 6010.1 6150.1 6167.6 6173.8 6185.7 6190.6 5923.2 5934.9 5936.5 5947.8 5984.8 5824.9 5914.0 6015.0 6021.8 6049.9 5863.1 5867.9 5880.8 5900.6 5910.2 5857.6 5864.5 5876.2 5879.8 5881.9 5645.8 5725.7 5732.7 5792.6 5793.1 5898.5 5939.7 5964.6 5994.7 5998.0 5799.2 5802.0 5835.2 5840.6 5841.4 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#1] ext.html Cycles:180 Average:50726.17 Median:40062.00 stddev:89171.59 (222.6%) stddev-sans-first:89342.12 12:58:39 INFO - PROCESS | 11897 | Values: 537.7 541.2 551.9 574.7 584.3 29751.4 39672.4 39693.2 39782.4 39862.4 41950.2 42260.2 42396.6 42457.2 42635.8 8585.4 8818.1 8826.0 8890.3 8893.4 8483.0 8597.1 8669.5 8677.9 8870.3 8872.5 8902.9 8927.2 8953.6 8965.5 8846.0 8886.6 8907.4 8918.9 8922.0 8837.8 8869.8 8925.1 8926.5 8953.5 43043.4 43312.8 43516.8 43561.0 43597.0 3690.3 3842.6 3873.1 4033.4 4163.0 32789.2 32913.5 33029.7 33471.0 33950.2 4276.3 4323.7 4341.4 4407.7 4410.2 282330.0 282638.0 282705.0 284198.0 285102.0 64503.0 64587.0 64802.0 64817.7 64850.4 68361.0 68610.7 68645.7 68720.0 68751.3 15245.8 15743.8 15786.2 15805.2 15821.4 11748.1 11907.4 11908.2 11958.3 11964.9 22280.2 22396.6 22451.1 22596.8 22599.7 7575.4 7789.9 7850.0 7852.7 7976.6 869.6 958.6 960.3 989.9 1109.8 28326.7 29607.4 30627.8 32687.8 33079.8 1113.5 1125.0 1195.3 1222.4 1248.6 14568.6 14822.8 14844.4 15065.1 15085.2 377814.0 381624.0 382038.0 506517.0 514303.0 48270.3 48566.8 48627.3 48679.5 48821.3 1447.8 1448.2 1448.7 1448.9 1450.4 28854.4 28936.6 29194.6 29547.9 29750.7 47394.5 47538.3 47826.0 47856.8 47953.3 267751.0 268022.0 269106.0 270295.0 270763.0 34954.0 35207.8 35491.6 35675.3 35724.5 46194.0 46552.8 46717.5 47541.8 47964.8 39960.4 40021.0 40103.0 40786.8 41152.8 39846.0 39984.0 40171.0 40354.0 40565.8 39092.8 39190.0 39552.4 39569.2 39592.4 34799.5 35080.5 35259.3 35655.3 35757.8 26927.9 27286.0 27342.6 27372.3 28855.9 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#2] jquery.html Cycles:180 Average:29070.43 Median:24210.49 stddev:96254.58 (397.6%) stddev-sans-first:96500.49 12:58:39 INFO - PROCESS | 11897 | Values: 379.3 379.7 380.9 381.4 386.4 15778.2 17274.0 17948.2 18004.9 18042.4 15577.1 16282.0 16575.4 16936.0 17034.2 4883.9 5016.6 5026.7 5034.3 5036.8 4864.6 4982.0 4987.8 5024.7 5063.2 4978.3 5014.0 5017.0 5145.1 5353.9 5301.9 5307.1 5340.1 5348.3 5368.0 5339.7 5349.7 5354.5 5391.4 5405.7 12951.5 19279.7 20441.9 21271.0 21460.6 2188.9 2203.6 2232.2 2264.0 2412.9 9988.9 10218.4 11718.9 12031.3 13220.6 1884.5 1963.3 1967.2 1996.4 2000.3 59267.7 59279.0 60522.4 60803.4 61019.7 10648.6 10878.3 10938.6 10998.8 11067.7 14311.5 14322.0 14420.8 14510.0 14568.3 7370.2 7414.0 7466.7 7482.7 7510.7 6902.6 6902.6 6903.0 6904.6 6966.7 4615.3 4719.2 4723.3 4766.6 4784.4 1888.5 1938.9 2010.8 2014.7 2041.6 466.5 941.8 1001.6 1067.5 1109.9 10705.3 11242.1 11300.7 11412.8 11477.7 481.5 500.7 501.4 502.7 503.8 6022.5 6145.0 6254.4 6270.0 6293.7 567678.0 568725.0 586089.0 596117.0 622254.0 76216.0 77134.2 77308.0 78618.6 79840.2 515.2 518.4 519.2 519.7 520.9 10358.8 10473.7 10574.2 10590.5 10802.1 32348.5 32910.2 33636.8 33720.7 34332.3 47053.3 47939.5 48126.8 48186.8 50502.5 7597.7 7687.5 7700.9 7730.7 8034.5 10409.5 11285.2 11517.7 11638.0 11850.8 9449.5 9625.6 9703.6 9991.6 10525.8 9381.4 9606.7 9613.0 10130.0 10457.7 9473.6 9596.5 10081.6 10136.0 10250.7 7904.4 8094.8 8108.2 8146.2 8161.2 10100.4 10735.6 10897.8 10917.7 10929.6 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#3] mootools.html Cycles:180 Average:5809.66 Median:6840.59 stddev:2984.12 (43.6%) stddev-sans-first:2974.01 12:58:39 INFO - PROCESS | 11897 | Values: 1392.1 1427.9 1564.7 1702.4 1763.9 7765.8 7933.1 8005.0 8211.4 8419.5 8191.9 8196.3 8234.5 8238.8 8242.6 2383.0 2412.5 2414.3 2417.1 2418.7 2425.7 2426.2 2491.1 2492.1 2492.8 2282.7 2345.8 2362.2 2439.4 2464.3 2426.5 2451.4 2455.3 2459.5 2462.9 2402.4 2413.1 2424.7 2427.0 2435.7 8009.3 8026.5 8032.1 8033.4 8052.2 4941.8 4960.2 5024.7 5066.6 5192.3 3262.5 3312.4 3314.4 3322.0 3326.4 1077.5 1089.3 1094.8 1119.7 1133.8 11648.4 11686.3 11707.2 11713.5 11812.1 4529.5 4534.7 4551.0 4573.3 4579.2 9491.6 9495.7 9496.8 9509.5 9519.1 5110.0 5112.3 5121.1 5145.1 5145.6 4482.4 4534.8 4551.7 4596.9 4624.8 3830.8 3842.5 3869.6 3892.4 3900.3 1127.6 1148.4 1171.2 1175.8 1198.6 1443.6 1450.5 1450.5 1470.6 1483.9 7637.3 7716.2 7717.8 7721.3 7721.8 1181.2 1197.3 1200.6 1211.2 1212.8 5854.7 5944.5 5987.1 6013.7 6053.8 9450.4 9608.9 9668.0 9751.5 9769.2 9282.6 9493.3 9516.2 9549.2 9561.7 7599.4 7686.8 7695.5 7736.1 7736.5 8074.9 8080.2 8083.4 8145.6 8156.3 9039.8 9055.7 9078.2 9164.4 9252.3 8826.2 9051.8 9284.3 9333.1 9468.1 7194.7 7338.7 7340.4 7352.6 7373.2 7813.4 7829.5 7907.0 7913.5 7924.0 7420.0 7450.8 7545.2 7577.4 7662.8 7366.2 7374.1 7417.4 7432.6 7458.2 7492.7 7499.6 7570.8 7592.5 7601.9 6798.6 6882.6 6895.4 6901.9 6926.4 6928.2 7018.9 7096.1 7098.3 7135.5 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#4] prototype.html Cycles:180 Average:5768.62 Median:6579.83 stddev:1770.60 (26.9%) stddev-sans-first:1728.38 12:58:39 INFO - PROCESS | 11897 | Values: 358.6 365.6 366.7 373.4 373.8 6439.7 6456.8 6486.9 6526.5 6528.3 6322.3 6400.7 6442.1 6488.8 6504.9 4918.1 4922.2 4928.3 4942.5 4942.9 4888.5 4894.6 4901.8 4902.5 4951.1 4464.9 4791.3 4836.9 4854.2 4866.4 4830.5 4839.4 4840.3 4847.0 4874.7 4198.6 4215.3 4216.9 4224.4 4230.7 5986.3 6145.5 6158.8 6172.7 6176.9 5743.8 5757.9 5767.9 5785.1 5786.2 6912.1 6935.5 6938.4 6944.8 6961.7 4753.0 4755.2 4756.4 4756.8 4784.9 6957.4 7139.6 7168.9 7181.1 7191.9 4850.4 4850.7 4853.1 4862.1 4866.2 4887.6 4919.5 4921.7 4929.0 4933.9 5547.6 5716.7 5732.9 5734.2 5743.1 6906.7 6946.8 6948.3 6956.6 6965.1 1640.4 1677.6 1677.9 1706.0 1712.6 1121.2 1132.3 1134.5 1135.9 1147.6 6630.2 6651.7 6655.1 6658.5 6659.9 7062.7 7102.3 7107.0 7109.1 7111.3 6535.4 6624.2 6630.9 6642.7 6657.5 3815.5 3838.9 3848.1 3855.3 3856.9 7263.5 7309.2 7309.6 7314.0 7323.7 7108.5 7281.9 7288.2 7290.2 7431.4 7424.6 7458.2 7476.3 7484.7 7484.8 7178.3 7220.3 7239.2 7241.3 7254.7 6948.8 7114.2 7126.3 7151.2 7153.3 7441.2 7446.1 7459.1 7472.0 7492.5 4827.3 4862.7 4885.7 4895.4 4920.8 6999.3 7081.6 7113.3 7190.6 7203.1 6945.1 6994.8 7023.9 7025.8 7031.2 7047.1 7051.5 7052.4 7056.4 7059.8 6645.8 6841.8 6874.0 6876.9 6891.1 7008.7 7011.6 7013.5 7021.3 7022.2 6706.8 6844.3 6845.2 6850.6 6854.3 12:58:39 INFO - PROCESS | 11897 | 12:58:39 INFO - PROCESS | 11897 | [#5] yui.html Cycles:180 Average:14394.90 Median:46930.03 stddev:16640.57 (35.5%) stddev-sans-first:16655.93 12:58:39 INFO - PROCESS | 11897 | Values: 797.5 820.5 864.9 914.6 933.5 14794.1 14915.6 14998.8 15028.0 15035.8 12894.4 13020.6 13648.7 13661.7 13689.2 880.6 897.4 897.5 900.2 901.0 893.3 895.7 895.8 897.1 898.8 930.2 932.2 933.3 933.8 935.0 928.5 929.6 932.1 932.7 933.3 682.5 684.6 687.3 690.3 691.1 13124.5 13159.1 13204.4 13206.0 13217.8 11926.8 12030.7 12117.7 12190.1 12590.6 9802.1 9890.1 10242.5 10282.1 10615.5 3650.8 3767.5 3796.1 3821.4 3837.5 44971.8 45434.3 48868.8 49655.5 52023.5 10149.1 10378.3 10511.2 10569.1 10586.9 17477.1 17488.0 17500.7 17512.2 17546.4 8121.2 8154.7 8174.0 8304.8 8394.9 4392.2 4401.1 4407.8 4526.5 4680.6 3264.2 3275.3 3293.2 3294.3 3300.1 588.2 602.3 603.8 607.8 608.5 666.9 675.9 676.6 699.5 722.0 9498.5 9567.7 9715.4 9755.6 9864.2 579.0 661.4 663.9 687.6 692.4 4037.0 4097.7 4145.1 4148.8 4196.1 61130.4 61817.4 62133.0 62186.4 62338.4 51510.7 54245.0 54467.5 55059.4 55518.7 46038.3 46080.5 46496.0 46900.5 46959.5 9492.1 9662.0 9841.6 9920.6 10048.6 35473.6 36255.8 36374.6 36684.0 36795.0 45524.0 46991.3 47259.8 48648.3 49034.8 12235.8 12287.8 12364.0 12517.4 12542.6 13395.1 13445.9 13601.7 13717.4 13754.2 12259.4 12559.1 12795.0 13003.3 13186.5 12681.8 12688.8 12889.8 13186.1 13275.4 11568.6 11617.2 11660.8 11854.2 12015.6 8825.9 9041.6 9180.4 9305.7 9312.5 8581.6 8684.5 8789.7 8861.1 8882.5 12:58:39 INFO - PROCESS | 11897 | -------- Summary: end -------- 12:58:39 INFO - PROCESS | 11897 | 12:58:40 INFO - TEST-INFO | 11897: exit 0 12:58:40 INFO - TEST-OK | dromaeo_css | took 1108342ms 12:58:40 INFO - TEST-START | kraken 12:58:40 INFO - operating with platform_type : linux_ 12:58:40 INFO - Initialising browser for kraken test... 12:58:40 INFO - TEST-INFO | started process 12134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUJeC9/profile http://localhost:55685/getInfo.html) 12:58:43 INFO - PROCESS | 12134 | 12:58:43 INFO - PROCESS | 12134 | (process:12214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:44 INFO - PROCESS | 12134 | __metrics Screen width/height:1600/1200 12:58:44 INFO - PROCESS | 12134 | colorDepth:24 12:58:44 INFO - PROCESS | 12134 | Browser inner width/height: 1024/697 12:58:44 INFO - PROCESS | 12134 | __metrics 12:58:44 INFO - TEST-INFO | 12134: exit 0 12:58:44 INFO - Browser initialized. 12:58:44 INFO - Running cycle 1/1 for kraken test... 12:58:44 INFO - TEST-INFO | started process 12262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUJeC9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:46 INFO - PROCESS | 12262 | 12:58:46 INFO - PROCESS | 12262 | (process:12325): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:56 INFO - PROCESS | 12262 | RSS: Main: 137809920 12:58:56 INFO - PROCESS | 12262 | 12:58:59 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55685/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:59 INFO - PROCESS | 12262 | RSS: Main: 141668352 12:58:59 INFO - PROCESS | 12262 | 12:59:02 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55685/tests/kraken/driver.html?testName=audio-dft) 12:59:02 INFO - PROCESS | 12262 | RSS: Main: 143175680 12:59:02 INFO - PROCESS | 12262 | 12:59:05 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55685/tests/kraken/driver.html?testName=audio-fft) 12:59:06 INFO - PROCESS | 12262 | RSS: Main: 143040512 12:59:06 INFO - PROCESS | 12262 | 12:59:08 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55685/tests/kraken/driver.html?testName=audio-oscillator) 12:59:08 INFO - PROCESS | 12262 | RSS: Main: 142983168 12:59:08 INFO - PROCESS | 12262 | 12:59:11 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:11 INFO - PROCESS | 12262 | RSS: Main: 143077376 12:59:11 INFO - PROCESS | 12262 | 12:59:14 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55685/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:15 INFO - PROCESS | 12262 | RSS: Main: 142258176 12:59:15 INFO - PROCESS | 12262 | 12:59:18 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55685/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:19 INFO - PROCESS | 12262 | RSS: Main: 142409728 12:59:19 INFO - PROCESS | 12262 | 12:59:22 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55685/tests/kraken/driver.html?testName=json-parse-financial) 12:59:22 INFO - PROCESS | 12262 | RSS: Main: 143278080 12:59:22 INFO - PROCESS | 12262 | 12:59:24 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:24 INFO - PROCESS | 12262 | RSS: Main: 143507456 12:59:24 INFO - PROCESS | 12262 | 12:59:26 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:27 INFO - PROCESS | 12262 | RSS: Main: 143699968 12:59:27 INFO - PROCESS | 12262 | 12:59:29 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:29 INFO - PROCESS | 12262 | RSS: Main: 143851520 12:59:29 INFO - PROCESS | 12262 | 12:59:31 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:32 INFO - PROCESS | 12262 | RSS: Main: 143839232 12:59:32 INFO - PROCESS | 12262 | 12:59:34 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:35 INFO - PROCESS | 12262 | RSS: Main: 143896576 12:59:35 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:55685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55685/tests/kraken/driver.html?testName=ai-astar) 12:59:37 INFO - PROCESS | 12262 | RSS: Main: 144396288 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | __start_tp_report 12:59:37 INFO - PROCESS | 12262 | _x_x_mozilla_page_load 12:59:37 INFO - PROCESS | 12262 | _x_x_mozilla_page_load_details 12:59:37 INFO - PROCESS | 12262 | |i|pagename|runs| 12:59:37 INFO - PROCESS | 12262 | |0;ai-astar;113;106;111;109;110;121;110;110;110;112 12:59:37 INFO - PROCESS | 12262 | |1;audio-beat-detection;150;126;168;162;124;152;151;129;160;128 12:59:37 INFO - PROCESS | 12262 | |2;audio-dft;162;161;161;163;161;160;161;160;162;162 12:59:37 INFO - PROCESS | 12262 | |3;audio-fft;73;77;73;148;75;75;73;74;156;74 12:59:37 INFO - PROCESS | 12262 | |4;audio-oscillator;94;95;148;95;95;97;138;95;95;138 12:59:37 INFO - PROCESS | 12262 | |5;imaging-gaussian-blur;109;110;109;110;111;109;109;109;110;109 12:59:37 INFO - PROCESS | 12262 | |6;imaging-darkroom;146;146;148;146;147;148;148;146;147;147 12:59:37 INFO - PROCESS | 12262 | |7;imaging-desaturate;96;96;96;96;96;96;98;97;96;97 12:59:37 INFO - PROCESS | 12262 | |8;json-parse-financial;56;64;58;60;57;57;63;57;57;57 12:59:37 INFO - PROCESS | 12262 | |9;json-stringify-tinderbox;63;65;66;64;65;69;64;66;63;65 12:59:37 INFO - PROCESS | 12262 | |10;stanford-crypto-aes;78;78;80;78;86;78;78;78;79;78 12:59:37 INFO - PROCESS | 12262 | |11;stanford-crypto-ccm;112;110;114;116;120;117;109;110;110;114 12:59:37 INFO - PROCESS | 12262 | |12;stanford-crypto-pbkdf2;125;135;139;135;133;128;137;136;136;134 12:59:37 INFO - PROCESS | 12262 | |13;stanford-crypto-sha256-iterative;65;64;64;65;65;69;65;65;62;64 12:59:37 INFO - PROCESS | 12262 | __end_tp_report 12:59:37 INFO - PROCESS | 12262 | __start_cc_report 12:59:37 INFO - PROCESS | 12262 | _x_x_mozilla_cycle_collect,692 12:59:37 INFO - PROCESS | 12262 | __end_cc_report 12:59:37 INFO - PROCESS | 12262 | __startTimestamp1457729977410__endTimestamp 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | ------- Summary: start ------- 12:59:37 INFO - PROCESS | 12262 | Number of tests: 14 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#0] ai-astar Cycles:10 Average:111.20 Median:110.50 stddev:3.91 (3.5%) stddev-sans-first:4.09 12:59:37 INFO - PROCESS | 12262 | Values: 113.0 106.0 111.0 109.0 110.0 121.0 110.0 110.0 110.0 112.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.50 stddev:16.67 (11.0%) stddev-sans-first:17.58 12:59:37 INFO - PROCESS | 12262 | Values: 150.0 126.0 168.0 162.0 124.0 152.0 151.0 129.0 160.0 128.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 12:59:37 INFO - PROCESS | 12262 | Values: 162.0 161.0 161.0 163.0 161.0 160.0 161.0 160.0 162.0 162.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#3] audio-fft Cycles:10 Average:89.80 Median:74.00 stddev:32.86 (44.4%) stddev-sans-first:34.29 12:59:37 INFO - PROCESS | 12262 | Values: 73.0 77.0 73.0 148.0 75.0 75.0 73.0 74.0 156.0 74.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.49 (23.7%) stddev-sans-first:23.19 12:59:37 INFO - PROCESS | 12262 | Values: 94.0 95.0 148.0 95.0 95.0 97.0 138.0 95.0 95.0 138.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 12:59:37 INFO - PROCESS | 12262 | Values: 109.0 110.0 109.0 110.0 111.0 109.0 109.0 109.0 110.0 109.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 12:59:37 INFO - PROCESS | 12262 | Values: 146.0 146.0 148.0 146.0 147.0 148.0 148.0 146.0 147.0 147.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 12:59:37 INFO - PROCESS | 12262 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 98.0 97.0 96.0 97.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:2.80 (4.9%) stddev-sans-first:2.80 12:59:37 INFO - PROCESS | 12262 | Values: 56.0 64.0 58.0 60.0 57.0 57.0 63.0 57.0 57.0 57.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.76 (2.7%) stddev-sans-first:1.72 12:59:37 INFO - PROCESS | 12262 | Values: 63.0 65.0 66.0 64.0 65.0 69.0 64.0 66.0 63.0 65.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.00 stddev:2.51 (3.2%) stddev-sans-first:2.64 12:59:37 INFO - PROCESS | 12262 | Values: 78.0 78.0 80.0 78.0 86.0 78.0 78.0 78.0 79.0 78.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:114.00 stddev:3.65 (3.2%) stddev-sans-first:3.84 12:59:37 INFO - PROCESS | 12262 | Values: 112.0 110.0 114.0 116.0 120.0 117.0 109.0 110.0 110.0 114.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.80 Median:135.50 stddev:4.24 (3.1%) stddev-sans-first:3.07 12:59:37 INFO - PROCESS | 12262 | Values: 125.0 135.0 139.0 135.0 133.0 128.0 137.0 136.0 136.0 134.0 12:59:37 INFO - PROCESS | 12262 | 12:59:37 INFO - PROCESS | 12262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.86 12:59:37 INFO - PROCESS | 12262 | Values: 65.0 64.0 64.0 65.0 65.0 69.0 65.0 65.0 62.0 64.0 12:59:37 INFO - PROCESS | 12262 | -------- Summary: end -------- 12:59:37 INFO - PROCESS | 12262 | 12:59:38 INFO - TEST-INFO | 12262: exit 0 12:59:38 INFO - TEST-OK | kraken | took 58079ms 12:59:38 INFO - TEST-START | v8_7 12:59:38 INFO - operating with platform_type : linux_ 12:59:38 INFO - Initialising browser for v8_7 test... 12:59:38 INFO - TEST-INFO | started process 12552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4fPHY/profile http://localhost:55685/getInfo.html) 12:59:41 INFO - PROCESS | 12552 | 12:59:41 INFO - PROCESS | 12552 | (process:12632): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:59:42 INFO - PROCESS | 12552 | __metrics Screen width/height:1600/1200 12:59:42 INFO - PROCESS | 12552 | colorDepth:24 12:59:42 INFO - PROCESS | 12552 | Browser inner width/height: 1024/697 12:59:42 INFO - PROCESS | 12552 | __metrics 12:59:43 INFO - TEST-INFO | 12552: exit 0 12:59:43 INFO - Browser initialized. 12:59:43 INFO - Running cycle 1/1 for v8_7 test... 12:59:43 INFO - TEST-INFO | started process 12680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4fPHY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:44 INFO - PROCESS | 12680 | 12:59:44 INFO - PROCESS | 12680 | (process:12744): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:59:54 INFO - PROCESS | 12680 | RSS: Main: 137744384 12:59:54 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | Cycle 1(1): loaded http://localhost:55685/tests/v8_7/run.html (next: http://localhost:55685/tests/v8_7/run.html) 13:00:17 INFO - PROCESS | 12680 | RSS: Main: 141832192 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | __start_tp_report 13:00:17 INFO - PROCESS | 12680 | _x_x_mozilla_page_load 13:00:17 INFO - PROCESS | 12680 | _x_x_mozilla_page_load_details 13:00:17 INFO - PROCESS | 12680 | |i|pagename|runs| 13:00:17 INFO - PROCESS | 12680 | |0;Richards;167.16817118020728 13:00:17 INFO - PROCESS | 12680 | |1;DeltaBlue;167.000668002672 13:00:17 INFO - PROCESS | 12680 | |2;Encrypt;278.9400278940028 13:00:17 INFO - PROCESS | 12680 | |3;Decrypt;5202.072538860104 13:00:17 INFO - PROCESS | 12680 | |4;RayTrace;918.2736455463728 13:00:17 INFO - PROCESS | 12680 | |5;Earley;553.7098560354374 13:00:17 INFO - PROCESS | 12680 | |6;Boyer;10752.68817204301 13:00:17 INFO - PROCESS | 12680 | |7;RegExp;39549.01960784314 13:00:17 INFO - PROCESS | 12680 | |8;Splay;518.9413596263622 13:00:17 INFO - PROCESS | 12680 | |9;NavierStokes;4822.115384615385 13:00:17 INFO - PROCESS | 12680 | __end_tp_report 13:00:17 INFO - PROCESS | 12680 | __startTimestamp1457730017409__endTimestamp 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | ------- Summary: start ------- 13:00:17 INFO - PROCESS | 12680 | Number of tests: 10 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 167.2 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#1] DeltaBlue Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 167.0 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 278.9 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 5202.1 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#4] RayTrace Cycles:1 Average:918.27 Median:918.27 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 918.3 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 553.7 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#6] Boyer Cycles:1 Average:10752.69 Median:10752.69 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 10752.7 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#7] RegExp Cycles:1 Average:39549.02 Median:39549.02 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 39549.0 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#8] Splay Cycles:1 Average:518.94 Median:518.94 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 518.9 13:00:17 INFO - PROCESS | 12680 | 13:00:17 INFO - PROCESS | 12680 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:00:17 INFO - PROCESS | 12680 | Values: 4822.1 13:00:17 INFO - PROCESS | 12680 | -------- Summary: end -------- 13:00:17 INFO - PROCESS | 12680 | 13:00:18 INFO - TEST-INFO | 12680: exit 0 13:00:18 INFO - TEST-OK | v8_7 | took 39918ms 13:00:18 INFO - SUITE-END | took 1206s 13:00:18 INFO - Completed test suite (00:20:06) 13:00:18 INFO - Working with test: dromaeo_css 13:00:18 INFO - Generating results file: dromaeo_css 13:00:18 INFO - Working with test: kraken 13:00:18 INFO - Generating results file: kraken 13:00:18 INFO - javascript benchmark 13:00:18 INFO - Working with test: v8_7 13:00:18 INFO - Generating results file: v8_7 13:00:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,43]] 13:00:18 INFO - process_Request line: dromaeo_css 7206.85 graph.html#tests=[[72,181,43]] 13:00:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:18 INFO - process_Request line: kraken 1483.60 graph.html#tests=[[232,181,43]] 13:00:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:18 INFO - process_Request line: v8_7 22179.03 graph.html#tests=[[230,181,43]] 13:00:18 INFO - RETURN: dromaeo_css: 7206.85 13:00:18 INFO - RETURN: kraken: 1483.60 13:00:18 INFO - RETURN: v8_7: 22179.03 13:00:18 INFO - javascript benchmark 13:00:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3368.983155084226, 3380.34083353746, 3383.813890236036, 3398.048546407007, 3407.539982102417, 5470.5350045246205, 5479.232907392963, 5488.807891723791, 5489.615726899118, 5495.230667706524, 5411.269478620385, 5467.863303417416, 5497.422770609089, 5501.724913754317, 5550.833474995757, 4972.651914365987, 5029.698218106907, 5095.770690318945, 5110.361204849394, 5156.819511317105, 4913.926291105637, 5069.340985671857, 5073.162928116856, 5082.161443361841, 5167.534921857032, 5184.766685499143, 5185.662931909433, 5223.373195216579, 5229.163333866582, 5229.37247530295, 5156.329677141966, 5157.871053223662, 5181.4300426953005, 5198.454162312941, 5202.557782588485, 4969.701817890938, 5018.698878067327, 5033.0688822567945, 5081.3140226069745, 5103.18349064148, 5369.9463005369835, 5379.704116273603, 5413.242146099549, 5431.212474191259, 5434.266374039533, 5971.581989260753, 6043.214382130295, 6062.848428789272, 6070.0, 6083.209182806251, 5850.619709718854, 5877.441643043904, 5925.703714814285, 6022.819315420545, 6046.27444706638, 5686.232358631573, 5694.060480020833, 5717.085266357404, 5717.313922329347, 5734.655920644775, 6177.382261773877, 6210.782622608277, 6211.378862113753, 6213.65824879627, 6214.627122372672, 5691.658500489983, 5771.249737534094, 5842.737076831553, 5913.438223368773, 5948.762049518057, 5958.523318134538, 5959.046552551571, 5961.672108034013, 5962.612430192024, 5975.043992961192, 5810.4189581041555, 5896.1450589664255, 5949.375315591887, 5953.613015154001, 5979.222701048836, 5866.090755932837, 5898.705064746746, 5937.0, 6003.859266739393, 6050.364711705296, 4530.22986092365, 4539.455265368177, 4557.043020965568, 4567.977160114245, 4578.771061446981, 4025.376066709665, 4115.135821477524, 4122.732022418533, 4127.711060225755, 4134.441850350164, 5600.943990560124, 5604.551635869121, 5618.297712785902, 5683.0, 5721.5136713379825, 6024.246969128859, 6030.939690603125, 6039.396060394013, 6041.6375017499095, 6047.818565443044, 5528.115501519737, 5699.715014249354, 5716.628419152742, 5732.254806875163, 5736.254286942671, 5021.5229553192385, 5065.797368105308, 5092.719900405439, 5108.591312694975, 5147.97426012875, 6069.696515174312, 6081.787137450168, 6097.939020609737, 6102.72537735803, 6180.81457556274, 5860.413958604106, 5955.940440595712, 5956.970215148896, 5981.342052374148, 6010.128531363015, 6150.138980542817, 6167.629942203482, 6173.81478555644, 6185.690715464299, 6190.597611155261, 5923.170756094064, 5934.9406505934385, 5936.525077993837, 5947.762089516544, 5984.760609575568, 5824.883502329845, 5914.0, 6015.037593984942, 6021.849453763691, 6049.939500605114, 5863.091220860773, 5867.882642347044, 5880.8235752927485, 5900.616459930091, 5910.1725758392995, 5857.648541087548, 5864.472197502245, 5876.206712093813, 5879.794207202727, 5881.94118058831, 5645.774169033192, 5725.713714314351, 5732.684702341411, 5792.565557583114, 5793.131030345482, 5898.528117750656, 5939.703014849154, 5964.582479226413, 5994.700264986646, 5997.970010149921, 5799.159121927381, 5802.0426629605645, 5835.153902684002, 5840.561957853093, 5841.4450627190345], "unit": "score", "name": "dojo.html", "value": 5519.013538237421}, {"lowerIsBetter": false, "replicates": [537.6962016460697, 541.1530954056904, 551.8510002299378, 574.7471112710407, 584.2550747796558, 29751.404971900574, 39672.40491392628, 39693.206135877335, 39782.40326395106, 39862.402063969064, 41950.16099678005, 42260.15479690404, 42396.576034239646, 42457.15085698292, 42635.78682106593, 8585.441946273488, 8818.07410221924, 8826.0, 8890.288776897833, 8893.377463577552, 8482.957585212096, 8597.054324024351, 8669.523176225304, 8677.869831952527, 8870.334724895627, 8872.512011839346, 8902.910970890305, 8927.241184499326, 8953.641854325819, 8965.506897120657, 8845.95577022114, 8886.600102995317, 8907.421017633866, 8918.866217006751, 8921.973972993092, 8837.779055523599, 8869.778255543599, 8925.062868398789, 8926.509042002688, 8953.462792232487, 43043.35434968478, 43312.78343608294, 43516.78241608771, 43561.0, 43597.0, 3690.280395322913, 3842.5965273646143, 3873.0511024799102, 4033.4151548025666, 4162.958370416318, 32789.19659418731, 32913.506297405555, 33029.6697033029, 33471.0, 33950.1512462188, 4276.273033584298, 4323.7405755654445, 4341.39220509129, 4407.691461597689, 4410.206162890679, 282330.0, 282638.0, 282705.0, 284198.0, 285102.0, 64503.0, 64587.0, 64802.0, 64817.67591162014, 64850.35149648443, 68361.0, 68610.65694671594, 68645.65677171582, 68720.0, 68751.3124868755, 15245.771313430307, 15743.763843542356, 15786.21068946548, 15805.209739512979, 15821.446249381446, 11748.118891083202, 11907.404629768476, 11908.225965312227, 11958.282503049844, 11964.88035119655, 22280.220192293516, 22396.55206895853, 22451.101955921582, 22596.774032259797, 22599.661005084938, 7575.356094731899, 7789.922100779033, 7850.0, 7852.685892564347, 7976.561289129154, 869.5608717597572, 958.5973890965672, 960.2653969713175, 989.9455529945922, 1109.8446217529552, 28326.71673283282, 29607.407851842843, 30627.833136968817, 32687.83656081752, 33079.83460082732, 1113.471101226927, 1124.9887501124883, 1195.2708847602955, 1222.4376786678229, 1248.581725122076, 14568.562943111723, 14822.777658335133, 14844.406223751144, 15065.09609423438, 15085.24573771307, 377814.0, 381624.0, 382038.0, 506517.0, 514303.0, 48270.27594586084, 48566.75716621465, 48627.27059094117, 48679.513204868206, 48821.26768098481, 1447.7755947828105, 1448.2251995182737, 1448.6957738874955, 1448.898577099593, 1450.354592206479, 28854.42291154123, 28936.565951511166, 29194.56208156922, 29547.85226073856, 29750.702492974793, 47394.52605474039, 47538.28692569683, 47826.0, 47856.76071619619, 47953.28070078882, 267751.0, 268022.0, 269106.0, 270295.0, 270763.0, 34954.0, 35207.82396088003, 35491.645083548836, 35675.28649427049, 35724.46413303751, 46194.0, 46552.7672361636, 46717.53282467132, 47541.762291189705, 47964.7601761989, 39960.40059399053, 40020.993701888736, 40103.0, 40786.79606601948, 41152.794236028625, 39846.0, 39984.00039999023, 40171.0, 40354.0, 40565.79717101514, 39092.804535977135, 39190.0, 39552.40671389874, 39569.208615826945, 39592.40611390889, 34799.4780078294, 35080.482043240096, 35259.29481410409, 35655.28689426249, 35757.82121089378, 26927.86536067307, 27286.04498842531, 27342.589861152497, 27372.315692107855, 28855.85572072126], "unit": "score", "name": "ext.html", "value": 19557.851642769692}, {"lowerIsBetter": false, "replicates": [379.27369088196104, 379.65261785466294, 380.9200067985723, 381.41833703602003, 386.37407400011983, 15778.211089445525, 17274.0, 17948.19233134509, 18004.909975450137, 18042.368517101902, 15577.065376077415, 16282.0, 16575.419860304894, 16936.0, 17034.23345949432, 4883.853484395474, 5016.623753218505, 5026.698398096126, 5034.320366750497, 5036.773345199456, 4864.610831133501, 4981.950180498203, 4987.800487980477, 5024.723640199788, 5063.164577844651, 4978.278149668296, 5014.022265658198, 5017.0, 5145.099607568679, 5353.946460535403, 5301.920471192935, 5307.124324486455, 5340.06548853951, 5348.331458567679, 5367.973160134175, 5339.733013349317, 5349.652272602308, 5354.464553544653, 5391.406945236021, 5405.702686352249, 12951.48194072236, 19279.710804337945, 20441.897790510953, 21271.0428030739, 21460.57078858414, 2188.8686678799163, 2203.5813195492806, 2232.1852523828848, 2263.977360226393, 2412.9034838606435, 9988.924372836438, 10218.386896786216, 11718.945294923498, 12031.27812331263, 13220.603381898462, 1884.5100273928877, 1963.3226536844766, 1967.1836187982112, 1996.3711430899366, 2000.2798992362739, 59267.70366148185, 59279.0, 60522.39477605212, 60803.39196608021, 61019.69490152521, 10648.574057037787, 10878.292910960763, 10938.617148399768, 10998.835017474745, 11067.667969960914, 14311.499097531745, 14322.0, 14420.783688244685, 14509.984301098822, 14568.34442450071, 7370.226126256773, 7413.962930185315, 7466.738664146729, 7482.663280152297, 7510.6620202091035, 6902.550464402431, 6902.6203558803745, 6903.033575299462, 6904.551204171713, 6966.686499107553, 4615.284630882219, 4719.174144524694, 4723.338732577442, 4766.594839438687, 4784.354112194878, 1888.4901076709211, 1938.932137375185, 2010.8391328693963, 2014.74815648044, 2041.6018876319272, 466.48686444911004, 941.7975135345933, 1001.5593139018808, 1067.5409573883305, 1109.9056580190775, 10705.250632455809, 11242.100631949424, 11300.660980170607, 11412.771744565061, 11477.655670329903, 481.4559547711064, 500.7020822610541, 501.3958180392618, 502.7436007636132, 503.82869824259194, 6022.488088512438, 6144.969275153596, 6254.437100660963, 6270.0, 6293.748250070037, 567678.0, 568725.0, 586089.0, 596117.0, 622254.0, 76216.0, 77134.22865771383, 77308.0, 78618.6069069651, 79840.20159798444, 515.2065818639328, 518.3546484626588, 519.22894501665, 519.7271432497969, 520.8515573061659, 10358.792824143324, 10473.738156546147, 10574.15406767472, 10590.523426445983, 10802.081823044815, 32348.514772277966, 32910.17724556809, 33636.831815840764, 33720.662793371754, 34332.31335373328, 47053.29420058634, 47939.520604793506, 48126.75936620295, 48186.759066204446, 50502.494975051246, 7597.6581053853815, 7687.500312479671, 7700.884486732815, 7730.652120654697, 8034.51792892405, 10409.47952602382, 11285.21003529745, 11517.712057198638, 11638.0, 11850.8156178962, 9449.48027858447, 9625.614975400906, 9703.563339649874, 9991.550380233053, 10525.789484210427, 9381.437113773196, 9606.711798646053, 9613.0, 10130.0, 10457.68626941193, 9473.57368918414, 9596.472194029395, 10081.596736130472, 10136.0, 10250.692479225636, 7904.367650587824, 8094.757157285291, 8108.189181081844, 8146.2261085196815, 8161.224683655043, 10100.44447555362, 10735.570577177137, 10897.782044359226, 10917.672469825919, 10929.56281748721], "unit": "score", "name": "jquery.html", "value": 7853.393202808258}, {"lowerIsBetter": false, "replicates": [1392.053403685494, 1427.90004699671, 1564.6557757293392, 1702.4296860551715, 1763.8765286429955, 7765.767026989185, 7933.127355990837, 8004.999999999993, 8211.384146189044, 8419.452735572184, 8191.91808081919, 8196.344292456604, 8234.547099909503, 8238.835223295531, 8242.587870606476, 2382.9523409531844, 2412.4692567635093, 2414.263649586884, 2417.0815090265764, 2418.746031666676, 2425.672534207877, 2426.211481268586, 2491.0907518755703, 2492.1152990688224, 2492.763187497185, 2282.7260728712495, 2345.777151170636, 2362.185046159081, 2439.42673471734, 2464.3223113643803, 2426.514697060586, 2451.4116612013167, 2455.2879664897246, 2459.5449841779327, 2462.852228866274, 2402.3753824005707, 2413.1312727418117, 2424.7211570669424, 2426.963595546068, 2435.695538057743, 8009.319207867338, 8026.478278911852, 8032.1164671886045, 8033.397495187826, 8052.19478052196, 4941.777620007108, 4960.156773348539, 5024.723640199788, 5066.620003499752, 5192.273081768555, 3262.4943133814295, 3312.387208366436, 3314.4034073866696, 3322.0200040987966, 3326.3679900818765, 1077.4720387010386, 1089.2810744908322, 1094.7536804219067, 1119.748056687247, 1133.7732453509332, 11648.359340236284, 11686.298822070617, 11707.239029463057, 11713.472893719803, 11812.114091443176, 4529.5243999380245, 4534.659900507475, 4550.998780268335, 4573.3368661544555, 4579.22153233951, 9491.620335186653, 9495.715128546155, 9496.762580935532, 9509.524523773784, 9519.095685909828, 5110.0, 5112.258722485219, 5121.129408000649, 5145.099607568661, 5145.562627176657, 4482.439695038121, 4534.773261336986, 4551.681382303207, 4596.908061838744, 4624.838130665411, 3830.7701537907815, 3842.4620553122586, 3869.59369266223, 3892.4355968384994, 3900.258950799339, 1127.622246547416, 1148.3856136966683, 1171.244547267008, 1175.7766024455327, 1198.6284251881943, 1443.5741456270425, 1450.4923276853017, 1450.5430789301336, 1470.5735336752437, 1483.8664520193233, 7637.274458926393, 7716.2283771623515, 7717.845643087219, 7721.305082542486, 7721.806954826062, 1181.1908842442954, 1197.3175290084741, 1200.5557943560939, 1211.1521934645784, 1212.751385965875, 5854.677992710356, 5944.464998150187, 5987.101934709828, 6013.6993150342305, 6053.848653783691, 9450.43297402158, 9608.9039109608, 9668.0, 9751.463669498246, 9769.218462522982, 9282.62869485213, 9493.288003399774, 9516.23870090391, 9549.188318992825, 9561.665341713007, 7599.392048636207, 7686.846263074819, 7695.538267703956, 7736.071671399468, 7736.497127686683, 8074.919250807417, 8080.191980801873, 8083.434159608771, 8145.633446494803, 8156.347492200728, 9039.774005649911, 9055.728328150166, 9078.182963533314, 9164.358494905293, 9252.306077044113, 8826.205641492297, 9051.773705657411, 9284.30367722437, 9333.113354231336, 9468.053194680477, 7194.71221151169, 7338.70645174187, 7340.412766978736, 7352.603005428951, 7373.225811289952, 7813.413993950363, 7829.530228186327, 7907.0, 7913.485623434458, 7923.960380198293, 7420.03539539878, 7450.813729656802, 7545.207753186056, 7577.431692622965, 7662.770116896502, 7366.152892417441, 7374.078240219973, 7417.36952359034, 7432.591207483641, 7458.216887226763, 7492.737754178577, 7499.550026998179, 7570.810729731801, 7592.544447333178, 7601.923980760122, 6798.558093723892, 6882.621455819978, 6895.4138898192205, 6901.861962760817, 6926.376626103674, 6928.237893831775, 7018.859622807618, 7096.148462184571, 7098.3256590623805, 7135.464840137114], "unit": "score", "name": "mootools.html", "value": 4791.123398716978}, {"lowerIsBetter": false, "replicates": [358.55539131476974, 365.6106246847107, 366.66450198068765, 373.40628400842655, 373.8336440284075, 6439.742410303582, 6456.774012909549, 6486.902696459557, 6526.543141980063, 6528.34716528347, 6322.304546499881, 6400.743970241185, 6442.130312407823, 6488.80533583992, 6504.902426463606, 4918.0901533216465, 4922.163232250526, 4928.285398617199, 4942.505749425065, 4942.901141977176, 4888.486708895568, 4894.608431325485, 4901.754912254391, 4902.534259245366, 4951.059298733229, 4464.910701785962, 4791.329213910055, 4836.854894353175, 4854.150523658363, 4866.3673722416215, 4830.468648448686, 4839.4434640016325, 4840.346553215341, 4846.975765121169, 4874.731889746063, 4198.5591512891315, 4215.346621273708, 4216.9156616867795, 4224.38746381776, 4230.725002874834, 5986.2517185351835, 6145.477634401082, 6158.784442544489, 6172.660503672296, 6176.87646247077, 5743.770249190027, 5757.942420575782, 5767.8558036049435, 5785.074388097884, 5786.1610066540115, 6912.101426814482, 6935.549189302729, 6938.444924406035, 6944.756933507303, 6961.721531138748, 4752.952470475286, 4755.2153894607345, 4756.357891684613, 4756.833510827105, 4784.904301913977, 6957.408620267283, 7139.643017849086, 7168.856622867565, 7181.138263408372, 7191.856162876713, 4850.369451971221, 4850.684705494132, 4853.126437241331, 4862.1005114053305, 4866.221404575251, 4887.584555312838, 4919.458859525449, 4921.729304888266, 4929.0388374267395, 4933.901321973541, 5547.611667183259, 5716.657000579979, 5732.856678582985, 5734.197212390269, 5743.10981797822, 6906.654667266616, 6946.756863509753, 6948.270431604608, 6956.617386043715, 6965.094537710065, 1640.3520609359236, 1677.639307548883, 1677.9077150756825, 1705.976414151499, 1712.5889786451162, 1121.1927412263158, 1132.252713209278, 1134.5405110930087, 1135.8523391958993, 1147.6155487911642, 6630.204375474974, 6651.700673469705, 6655.068290439245, 6658.4673226141795, 6659.9001014984815, 7062.71749130029, 7102.254263302279, 7106.964465177641, 7109.075820143452, 7111.2533184015965, 6535.411812936859, 6624.238212605515, 6630.900536491957, 6642.7342906284175, 6657.500687448461, 3815.4849095372324, 3838.8848334550007, 3848.0572259796527, 3855.2674991752037, 3856.8842934712, 7263.4915555910575, 7309.159446663702, 7309.561426314438, 7314.0, 7323.7436689715605, 7108.537945033556, 7281.927180728125, 7288.234735352818, 7290.234525374759, 7431.368333691588, 7424.628768561551, 7458.216887226871, 7476.289752473506, 7484.738034168778, 7484.775456736306, 7178.28217178278, 7220.3140701633265, 7239.203687594466, 7241.312075352833, 7254.709811607477, 6948.756793512202, 7114.181869085121, 7126.322999315057, 7151.177614574391, 7153.284671532805, 7441.218672039358, 7446.069241344832, 7459.142198647008, 7471.962640186982, 7492.51298665585, 4827.300041493893, 4862.708237505761, 4885.65800393969, 4895.388076490439, 4920.827771027997, 6999.265077166824, 7081.575105493687, 7113.288671132846, 7190.640467976685, 7203.099612548432, 6945.062416573698, 6994.790156295319, 7023.929760702327, 7025.824354391181, 7031.22656507794, 7047.083879095685, 7051.471139664443, 7052.400545953651, 7056.435485161072, 7059.82350441243, 6645.833854153491, 6841.760538381132, 6873.965630171817, 6876.896846547205, 6891.104156459829, 7008.719651213894, 7011.6494175292055, 7013.509054366145, 7021.262767409348, 7022.157341119098, 6706.798796036127, 6844.281350458329, 6845.247022827385, 6850.623215723183, 6854.280300568368], "unit": "score", "name": "prototype.html", "value": 5189.679459036876}, {"lowerIsBetter": false, "replicates": [797.4856217739556, 820.4953953318707, 864.9048604653487, 914.6432891172448, 933.523902809567, 14794.112353258799, 14915.627109322273, 14998.77501837472, 15028.0, 15035.84964150361, 12894.355282235898, 13020.609381718563, 13648.72702545951, 13661.65845853854, 13689.17864928105, 880.5861245214738, 897.3673560140086, 897.4974014551839, 900.2213085680871, 900.9594568244445, 893.3255392178896, 895.7447127568644, 895.8387490251752, 897.1208215948375, 898.8382091223577, 930.186087173723, 932.202966463674, 933.3280038372361, 933.8319102561536, 934.9906500935006, 928.4800511713428, 929.6235024814927, 932.1098351074742, 932.6502561539422, 933.3046880074388, 682.4608559238196, 684.6063513479769, 687.3126873126873, 690.2614202803003, 691.0705101638289, 13124.540641077516, 13159.07886447949, 13204.405801738945, 13206.0, 13217.801732974012, 11926.761464770656, 12030.69923251917, 12117.697057573543, 12190.146689731722, 12590.559330423483, 9802.117809397188, 9890.060444257784, 10242.53908574116, 10282.12601928837, 10615.46922653872, 3650.7992060436663, 3767.472553842464, 3796.0699628590896, 3821.3503704370323, 3837.520309961255, 44971.77514112441, 45434.31848522275, 48868.755656221845, 49655.50344496545, 52023.47976520224, 10149.137323327452, 10378.323363450883, 10511.1591072714, 10569.109736618158, 10586.89413105859, 17477.126143692763, 17488.0, 17500.737488937677, 17512.21195046226, 17546.38587649426, 8121.187881211831, 8154.714584989615, 8174.0, 8304.8339033219, 8394.90866187404, 4392.2094023075515, 4401.053773438726, 4407.823687052546, 4526.524714904954, 4680.625549956064, 3264.2002709336366, 3275.263065810221, 3293.1602441377295, 3294.3081952789703, 3300.1254667513126, 588.205922005298, 602.3374288282854, 603.7675494934482, 607.8298076538576, 608.5496732417979, 666.9466442684574, 675.9256481786999, 676.6379986707088, 699.5208282326622, 721.974730884427, 9498.477583732962, 9567.665131720356, 9715.36850104741, 9755.560999755027, 9864.161546268504, 578.9797357092482, 661.3716968879584, 663.8838203314401, 687.5599616245606, 692.4010730717994, 4037.0, 4097.651699605567, 4145.108801607608, 4148.838325268869, 4196.118815048813, 61130.38869611336, 61817.38182618206, 62133.0, 62186.37813621896, 62338.37661623416, 51510.74244628753, 54245.0, 54467.45532544624, 55059.44940550623, 55518.72240638771, 46038.309425358646, 46080.5391946083, 46496.0, 46900.530994690984, 46959.5304046962, 9492.098250666175, 9662.0, 9841.557129929313, 9920.603175872884, 10048.598056077675, 35473.645263547034, 36255.81872090622, 36374.63625363712, 36684.0, 36795.0, 45524.0, 46991.295130572384, 47259.76370118128, 48648.2702759466, 49034.75482622564, 12235.816462752888, 12287.75424491523, 12364.0, 12517.436715348013, 12542.623721288375, 13395.062345635712, 13445.932770336085, 13601.727965440437, 13717.382717777524, 13754.243516606683, 12259.38703064861, 12559.058070644556, 12795.040371971952, 13003.349832508526, 13186.472541098248, 12681.80977285323, 12688.809667854805, 12889.8066529004, 13186.076974611686, 13275.40260688252, 11568.595099171489, 11617.186796924134, 11660.825087623523, 11854.170208085352, 12015.639530814089, 8825.867611985954, 9041.59312830911, 9180.403273787182, 9305.720828375159, 9312.534373281444, 8581.570921454027, 8684.478931264144, 8789.664844828167, 8861.113888611346, 8882.467051976902], "unit": "score", "name": "yui.html", "value": 6646.91848540049}], "name": "dromaeo_css", "value": 7206.848845449457}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 111.0, 109.0, 110.0, 121.0, 110.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 168.0, 162.0, 124.0, 152.0, 151.0, 129.0, 160.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 163.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 73.0, 148.0, 75.0, 75.0, 73.0, 74.0, 156.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 148.0, 95.0, 95.0, 97.0, 138.0, 95.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 111.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 146.0, 147.0, 148.0, 148.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [56.0, 64.0, 58.0, 60.0, 57.0, 57.0, 63.0, 57.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 66.0, 64.0, 65.0, 69.0, 64.0, 66.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 78.0, 86.0, 78.0, 78.0, 78.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 114.0, 116.0, 120.0, 117.0, 109.0, 110.0, 110.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.2}, {"lowerIsBetter": true, "replicates": [125.0, 135.0, 139.0, 135.0, 133.0, 128.0, 137.0, 136.0, 136.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.8}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 69.0, 65.0, 65.0, 62.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1483.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "DeltaBlue", "value": 395.91458399999993}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [918.2736455463728], "unit": "score", "name": "RayTrace", "value": 805.8480209999998}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10752.68817204301], "unit": "score", "name": "Boyer", "value": 61.98105900000006}, {"lowerIsBetter": false, "replicates": [39549.01960784314], "unit": "score", "name": "RegExp", "value": 23.0343257312841}, {"lowerIsBetter": false, "replicates": [518.9413596263622], "unit": "score", "name": "Splay", "value": 157.03315700000005}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22179.033343690106}]} 13:00:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,43]]", "result": "22179.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,43]]", "result": "1483.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,43]]", "result": "7206.85"}}} 13:00:18 INFO - Return code: 0 13:00:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:00:18 INFO - # TBPL SUCCESS # 13:00:18 INFO - Running post-action listener: _resource_record_post_action 13:00:18 INFO - Running post-run listener: _resource_record_post_run 13:00:19 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462925824; Read time: 12; Write time: 412444 13:00:19 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 230514688; Read time: 0; Write time: 276820 13:00:20 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 228016128; Read time: 12; Write time: 134924 13:00:20 INFO - Running post-run listener: _upload_blobber_files 13:00:20 INFO - Blob upload gear active. 13:00:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:20 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 13:00:20 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00:20 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:21 INFO - (blobuploader) - INFO - Done attempting. 13:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:22 INFO - (blobuploader) - INFO - Done attempting. 13:00:22 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:22 INFO - Return code: 0 13:00:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0c1669be973905ef5c3028e7da5e65ac840c48d8007a1483c8a29a6b1b5b9264e027fb1a9c04a064ebd5b605d961b62ad4c25587063c434e8eea121fc10253e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bdb4c2d540513c68c79c3e3249ac750e7129b87cfd57c09cc5a50514e651d6b6f258dd9bb34fed2d6b3e3403fdc004c890a2f22db696f4dffd86aa28b09e7728"} 13:00:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:22 INFO - Contents: 13:00:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0c1669be973905ef5c3028e7da5e65ac840c48d8007a1483c8a29a6b1b5b9264e027fb1a9c04a064ebd5b605d961b62ad4c25587063c434e8eea121fc10253e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bdb4c2d540513c68c79c3e3249ac750e7129b87cfd57c09cc5a50514e651d6b6f258dd9bb34fed2d6b3e3403fdc004c890a2f22db696f4dffd86aa28b09e7728"} 13:00:22 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:22 INFO - Copying logs to upload dir... 13:00:22 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.252914 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-11 13:00:21.673324) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:21.677089) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 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/Date-Non-PGO/sha512/0c1669be973905ef5c3028e7da5e65ac840c48d8007a1483c8a29a6b1b5b9264e027fb1a9c04a064ebd5b605d961b62ad4c25587063c434e8eea121fc10253e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bdb4c2d540513c68c79c3e3249ac750e7129b87cfd57c09cc5a50514e651d6b6f258dd9bb34fed2d6b3e3403fdc004c890a2f22db696f4dffd86aa28b09e7728"} build_url:https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011547 build_url: 'https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0c1669be973905ef5c3028e7da5e65ac840c48d8007a1483c8a29a6b1b5b9264e027fb1a9c04a064ebd5b605d961b62ad4c25587063c434e8eea121fc10253e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bdb4c2d540513c68c79c3e3249ac750e7129b87cfd57c09cc5a50514e651d6b6f258dd9bb34fed2d6b3e3403fdc004c890a2f22db696f4dffd86aa28b09e7728"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:21.702439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:21.702771) ========= 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=0274524eba3bdaad075c2247000001d4-1457728089.709160-74752985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:21.785671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:00:21.786008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:00:21.786332) ========= ========= Total master_lag: 0.56 =========