builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1453291540.13 results: success (0) buildid: 20160120024518 builduid: e8923a41b94846d8b4df1078244c2b67 revision: 7f066e9a778b6c0b627204d24b046ccd9ab9e613 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.129722) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.130182) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.130542) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.154255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.154611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.170025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.170341) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004708 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.219240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.222603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.222995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.223310) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 04:05:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.9M=0s 2016-01-20 04:05:42 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.390525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.390841) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021000 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.443039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.443431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7f066e9a778b6c0b627204d24b046ccd9ab9e613 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7f066e9a778b6c0b627204d24b046ccd9ab9e613 --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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 04:05:42,211 truncating revision to first 12 chars 2016-01-20 04:05:42,211 Setting DEBUG logging. 2016-01-20 04:05:42,211 attempt 1/10 2016-01-20 04:05:42,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7f066e9a778b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 04:05:42,447 unpacking tar archive at: fx-team-7f066e9a778b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.976923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:40.977625) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004719 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:41.031836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:41.032603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:41.043941) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:41.044624) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:05:41.045352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-20 04:05:41.045706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:42 INFO - MultiFileLogger online at 20160120 04:05:42 in /builds/slave/test 04:05:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:05:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:42 INFO - {'append_to_log': False, 04:05:42 INFO - 'base_work_dir': '/builds/slave/test', 04:05:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:05:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:42 INFO - 'branch': 'Fx-Team-Non-PGO', 04:05:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:42 INFO - 'config_files': ('talos/linux_config.py',), 04:05:42 INFO - 'default_actions': ('clobber', 04:05:42 INFO - 'read-buildbot-config', 04:05:42 INFO - 'download-and-extract', 04:05:42 INFO - 'populate-webroot', 04:05:42 INFO - 'create-virtualenv', 04:05:42 INFO - 'install', 04:05:42 INFO - 'run-tests'), 04:05:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:42 INFO - 'download_minidump_stackwalk': True, 04:05:42 INFO - 'download_symbols': 'ondemand', 04:05:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:42 INFO - 'installer_path': 'installer.exe', 04:05:42 INFO - 'log_level': 'info', 04:05:42 INFO - 'log_name': 'talos', 04:05:42 INFO - 'log_to_console': True, 04:05:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:42 INFO - 'opt_config_files': (), 04:05:42 INFO - 'pip_index': False, 04:05:42 INFO - 'sps_profile': False, 04:05:42 INFO - 'sps_profile_interval': 0, 04:05:42 INFO - 'suite': 'dromaeojs-e10s', 04:05:42 INFO - 'system_bits': '32', 04:05:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:42 INFO - 'title': 'talos-linux64-ix-054', 04:05:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:42 INFO - 'use_talos_json': True, 04:05:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:42 INFO - 'work_dir': 'build'} 04:05:42 INFO - ##### 04:05:42 INFO - ##### Running clobber step. 04:05:42 INFO - ##### 04:05:42 INFO - Running pre-action listener: _resource_record_pre_action 04:05:42 INFO - Running main action method: clobber 04:05:42 INFO - rmtree: /builds/slave/test/build 04:05:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:43 INFO - Running post-action listener: _resource_record_post_action 04:05:43 INFO - ##### 04:05:43 INFO - ##### Running read-buildbot-config step. 04:05:43 INFO - ##### 04:05:43 INFO - Running pre-action listener: _resource_record_pre_action 04:05:43 INFO - Running main action method: read_buildbot_config 04:05:43 INFO - Using buildbot properties: 04:05:43 INFO - { 04:05:43 INFO - "project": "", 04:05:43 INFO - "product": "firefox", 04:05:43 INFO - "script_repo_revision": "production", 04:05:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:05:43 INFO - "repository": "", 04:05:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:05:43 INFO - "buildid": "20160120024518", 04:05:43 INFO - "pgo_build": "False", 04:05:43 INFO - "basedir": "/builds/slave/test", 04:05:43 INFO - "buildnumber": 977, 04:05:43 INFO - "slavename": "talos-linux64-ix-054", 04:05:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:05:43 INFO - "platform": "ubuntu64_hw", 04:05:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:05:43 INFO - "branch": "fx-team", 04:05:43 INFO - "repo_path": "integration/fx-team", 04:05:43 INFO - "revision": "7f066e9a778b6c0b627204d24b046ccd9ab9e613", 04:05:43 INFO - "stage_platform": "linux64", 04:05:43 INFO - "builduid": "e8923a41b94846d8b4df1078244c2b67", 04:05:43 INFO - "slavebuilddir": "test" 04:05:43 INFO - } 04:05:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:05:43 INFO - Running post-action listener: _resource_record_post_action 04:05:43 INFO - ##### 04:05:43 INFO - ##### Running download-and-extract step. 04:05:43 INFO - ##### 04:05:43 INFO - Running pre-action listener: _resource_record_pre_action 04:05:43 INFO - Running main action method: download_and_extract 04:05:43 INFO - mkdir: /builds/slave/test/build/tests 04:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:43 INFO - https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/test_packages.json 04:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/test_packages.json 04:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:05:45 INFO - Downloaded 1448 bytes. 04:05:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:05:45 INFO - Using the following test package requirements: 04:05:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:45 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:05:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'jsshell-linux-x86_64.zip'], 04:05:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:45 INFO - https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:46 INFO - Downloaded 21217439 bytes. 04:05:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:47 INFO - Return code: 0 04:05:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:47 INFO - https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:49 INFO - Downloaded 21217439 bytes. 04:05:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:50 INFO - Return code: 0 04:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:50 INFO - https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:51 INFO - Downloaded 11132144 bytes. 04:05:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:05:52 INFO - Return code: 0 04:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:53 INFO - Downloaded 54191029 bytes. 04:05:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:53 INFO - mkdir: /builds/slave/test/properties 04:05:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:53 INFO - Contents: 04:05:53 INFO - build_url:https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:05:53 INFO - Running post-action listener: _resource_record_post_action 04:05:53 INFO - Running post-action listener: set_extra_try_arguments 04:05:53 INFO - ##### 04:05:53 INFO - ##### Running populate-webroot step. 04:05:53 INFO - ##### 04:05:53 INFO - Running pre-action listener: _resource_record_pre_action 04:05:53 INFO - Running main action method: populate_webroot 04:05:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:53 INFO - '--tppagecycles', 04:05:53 INFO - '7'], 04:05:53 INFO - 'tests': ['tsvgm']}}, 04:05:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'tests': ['damp', 'tps']}, 04:05:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['damp', 'tps']}, 04:05:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:53 INFO - 'other': {'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'other_l64': {'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:53 INFO - 'ts_paint', 04:05:53 INFO - 'tpaint', 04:05:53 INFO - 'sessionrestore', 04:05:53 INFO - 'sessionrestore_no_auto_restore']}, 04:05:53 INFO - 'svgr': {'tests': ['tsvgx', 04:05:53 INFO - 'tsvgr_opacity', 04:05:53 INFO - 'tart', 04:05:53 INFO - 'tscrollx', 04:05:53 INFO - 'cart']}, 04:05:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['tsvgx', 04:05:53 INFO - 'tsvgr_opacity', 04:05:53 INFO - 'tart', 04:05:53 INFO - 'tscrollx', 04:05:53 INFO - 'cart']}, 04:05:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'tests': ['tp5o']}, 04:05:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'talos_options': ['--e10s'], 04:05:53 INFO - 'tests': ['tp5o']}, 04:05:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'talos_options': ['--xperf_path', 04:05:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:53 INFO - 'tests': ['tp5n']}, 04:05:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:53 INFO - 'talos_options': ['--e10s', 04:05:53 INFO - '--xperf_path', 04:05:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:53 INFO - 'tests': ['tp5n']}}, 04:05:53 INFO - 'talos.zip': {'path': '', 04:05:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:53 INFO - Running post-action listener: _resource_record_post_action 04:05:53 INFO - ##### 04:05:53 INFO - ##### Running create-virtualenv step. 04:05:53 INFO - ##### 04:05:53 INFO - Running pre-action listener: _resource_record_pre_action 04:05:53 INFO - Running main action method: create_virtualenv 04:05:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:53 INFO - Using real prefix '/usr' 04:05:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:56 INFO - Installing pip.................done. 04:05:56 INFO - Return code: 0 04:05:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:56 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:56 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 04:05:56 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 04:05:56 INFO - Using env: {'DISPLAY': ':0', 04:05:56 INFO - 'HOME': '/home/cltbld', 04:05:56 INFO - 'LANG': 'en_US.UTF-8', 04:05:56 INFO - 'LANGUAGE': 'en_US:en', 04:05:56 INFO - 'LOGNAME': 'cltbld', 04:05:56 INFO - 'MAIL': '/var/mail/cltbld', 04:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:56 INFO - 'MOZ_NO_REMOTE': '1', 04:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:56 INFO - 'NO_EM_RESTART': '1', 04:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:56 INFO - 'PWD': '/builds/slave/test', 04:05:56 INFO - 'SHELL': '/bin/bash', 04:05:56 INFO - 'SHLVL': '1', 04:05:56 INFO - 'TERM': 'linux', 04:05:56 INFO - 'TMOUT': '86400', 04:05:56 INFO - 'USER': 'cltbld', 04:05:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:56 INFO - '_': '/tools/buildbot/bin/python'} 04:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:05:56 INFO - Cleaning up... 04:05:56 INFO - Return code: 0 04:05:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:56 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:56 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 04:05:56 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 04:05:56 INFO - Using env: {'DISPLAY': ':0', 04:05:56 INFO - 'HOME': '/home/cltbld', 04:05:56 INFO - 'LANG': 'en_US.UTF-8', 04:05:56 INFO - 'LANGUAGE': 'en_US:en', 04:05:56 INFO - 'LOGNAME': 'cltbld', 04:05:56 INFO - 'MAIL': '/var/mail/cltbld', 04:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:56 INFO - 'MOZ_NO_REMOTE': '1', 04:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:56 INFO - 'NO_EM_RESTART': '1', 04:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:56 INFO - 'PWD': '/builds/slave/test', 04:05:56 INFO - 'SHELL': '/bin/bash', 04:05:56 INFO - 'SHLVL': '1', 04:05:56 INFO - 'TERM': 'linux', 04:05:56 INFO - 'TMOUT': '86400', 04:05:56 INFO - 'USER': 'cltbld', 04:05:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:56 INFO - '_': '/tools/buildbot/bin/python'} 04:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:56 INFO - Downloading/unpacking psutil>=0.7.1 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:58 INFO - Installing collected packages: psutil 04:05:58 INFO - Running setup.py install for psutil 04:05:58 INFO - building 'psutil._psutil_linux' extension 04:05:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:05:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:05:58 INFO - building 'psutil._psutil_posix' extension 04:05:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:05:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:58 INFO - Successfully installed psutil 04:05:58 INFO - Cleaning up... 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:59 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 04:05:59 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 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:01 INFO - Installing collected packages: mozsystemmonitor 04:06:01 INFO - Running setup.py install for mozsystemmonitor 04:06:01 INFO - Successfully installed mozsystemmonitor 04:06:01 INFO - Cleaning up... 04:06:01 INFO - Return code: 0 04:06:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:01 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:01 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 04:06:01 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 04:06:01 INFO - Using env: {'DISPLAY': ':0', 04:06:01 INFO - 'HOME': '/home/cltbld', 04:06:01 INFO - 'LANG': 'en_US.UTF-8', 04:06:01 INFO - 'LANGUAGE': 'en_US:en', 04:06:01 INFO - 'LOGNAME': 'cltbld', 04:06:01 INFO - 'MAIL': '/var/mail/cltbld', 04:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:01 INFO - 'MOZ_NO_REMOTE': '1', 04:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:01 INFO - 'NO_EM_RESTART': '1', 04:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:01 INFO - 'PWD': '/builds/slave/test', 04:06:01 INFO - 'SHELL': '/bin/bash', 04:06:01 INFO - 'SHLVL': '1', 04:06:01 INFO - 'TERM': 'linux', 04:06:01 INFO - 'TMOUT': '86400', 04:06:01 INFO - 'USER': 'cltbld', 04:06:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:01 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - Downloading docopt-0.6.1.tar.gz 04:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:03 INFO - Running setup.py install for blobuploader 04:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:03 INFO - Running setup.py install for requests 04:06:04 INFO - Running setup.py install for docopt 04:06:04 INFO - Successfully installed blobuploader requests docopt 04:06:04 INFO - Cleaning up... 04:06:04 INFO - Return code: 0 04:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:04 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:04 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 04:06:04 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 04:06:04 INFO - Using env: {'DISPLAY': ':0', 04:06:04 INFO - 'HOME': '/home/cltbld', 04:06:04 INFO - 'LANG': 'en_US.UTF-8', 04:06:04 INFO - 'LANGUAGE': 'en_US:en', 04:06:04 INFO - 'LOGNAME': 'cltbld', 04:06:04 INFO - 'MAIL': '/var/mail/cltbld', 04:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:04 INFO - 'MOZ_NO_REMOTE': '1', 04:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:04 INFO - 'NO_EM_RESTART': '1', 04:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:04 INFO - 'PWD': '/builds/slave/test', 04:06:04 INFO - 'SHELL': '/bin/bash', 04:06:04 INFO - 'SHLVL': '1', 04:06:04 INFO - 'TERM': 'linux', 04:06:04 INFO - 'TMOUT': '86400', 04:06:04 INFO - 'USER': 'cltbld', 04:06:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:04 INFO - '_': '/tools/buildbot/bin/python'} 04:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:04 INFO - Running setup.py (path:/tmp/pip-SvWCD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:04 INFO - Running setup.py (path:/tmp/pip-CGxED6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:04 INFO - Running setup.py (path:/tmp/pip-Rcs_Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:04 INFO - Running setup.py (path:/tmp/pip-L2idZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:04 INFO - Running setup.py (path:/tmp/pip-I6rCU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:04 INFO - Running setup.py (path:/tmp/pip-F_eOkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:05 INFO - Running setup.py (path:/tmp/pip-_RRaqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:05 INFO - Running setup.py (path:/tmp/pip-thEKqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:05 INFO - Running setup.py (path:/tmp/pip-9evEdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:05 INFO - Running setup.py (path:/tmp/pip-e6edlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:05 INFO - Running setup.py (path:/tmp/pip-685nNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:05 INFO - Running setup.py (path:/tmp/pip-hhAXG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:05 INFO - Running setup.py (path:/tmp/pip-dvCNyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:05 INFO - Running setup.py (path:/tmp/pip-Ovu3at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:05 INFO - Running setup.py (path:/tmp/pip-3ojbIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:05 INFO - Running setup.py (path:/tmp/pip-HaOjvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:05 INFO - Running setup.py (path:/tmp/pip-zgX3ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:05 INFO - Running setup.py install for manifestparser 04:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozcrash 04:06:06 INFO - Running setup.py install for mozdebug 04:06:06 INFO - Running setup.py install for mozdevice 04:06:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozfile 04:06:06 INFO - Running setup.py install for mozhttpd 04:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozinfo 04:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozInstall 04:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozleak 04:06:06 INFO - Running setup.py install for mozlog 04:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for moznetwork 04:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozprocess 04:06:07 INFO - Running setup.py install for mozprofile 04:06:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozrunner 04:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozscreenshot 04:06:07 INFO - Running setup.py install for moztest 04:06:07 INFO - Running setup.py install for mozversion 04:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:07 INFO - Cleaning up... 04:06:07 INFO - Return code: 0 04:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:07 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:07 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 04:06:07 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 04:06:07 INFO - Using env: {'DISPLAY': ':0', 04:06:07 INFO - 'HOME': '/home/cltbld', 04:06:07 INFO - 'LANG': 'en_US.UTF-8', 04:06:07 INFO - 'LANGUAGE': 'en_US:en', 04:06:07 INFO - 'LOGNAME': 'cltbld', 04:06:07 INFO - 'MAIL': '/var/mail/cltbld', 04:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:07 INFO - 'MOZ_NO_REMOTE': '1', 04:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:07 INFO - 'NO_EM_RESTART': '1', 04:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:07 INFO - 'PWD': '/builds/slave/test', 04:06:07 INFO - 'SHELL': '/bin/bash', 04:06:07 INFO - 'SHLVL': '1', 04:06:07 INFO - 'TERM': 'linux', 04:06:07 INFO - 'TMOUT': '86400', 04:06:07 INFO - 'USER': 'cltbld', 04:06:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:07 INFO - '_': '/tools/buildbot/bin/python'} 04:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:07 INFO - Running setup.py (path:/tmp/pip-9snu07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:07 INFO - Running setup.py (path:/tmp/pip-oVYfmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:08 INFO - Running setup.py (path:/tmp/pip-wF6Vb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:08 INFO - Running setup.py (path:/tmp/pip-mdZEXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:08 INFO - Running setup.py (path:/tmp/pip-kKme2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:08 INFO - Running setup.py (path:/tmp/pip-LcCA5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:08 INFO - Running setup.py (path:/tmp/pip-cOQeeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:08 INFO - Running setup.py (path:/tmp/pip-WxgtqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:08 INFO - Running setup.py (path:/tmp/pip-ddJiyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:08 INFO - Running setup.py (path:/tmp/pip-lgae2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:08 INFO - Running setup.py (path:/tmp/pip-3RQ8C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:08 INFO - Running setup.py (path:/tmp/pip-uBClYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:08 INFO - Running setup.py (path:/tmp/pip-M8nnPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:08 INFO - Running setup.py (path:/tmp/pip-pSlGB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:08 INFO - Running setup.py (path:/tmp/pip-8VJV5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:08 INFO - Running setup.py (path:/tmp/pip-a7dvtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Running setup.py (path:/tmp/pip-G863GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:10 INFO - Downloading blessings-1.5.1.tar.gz 04:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:10 INFO - Installing collected packages: blessings 04:06:10 INFO - Running setup.py install for blessings 04:06:10 INFO - Successfully installed blessings 04:06:10 INFO - Cleaning up... 04:06:11 INFO - Return code: 0 04:06:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:11 INFO - Reading from file tmpfile_stdout 04:06:11 INFO - Current package versions: 04:06:11 INFO - argparse == 1.2.1 04:06:11 INFO - blessings == 1.5.1 04:06:11 INFO - blobuploader == 1.2.4 04:06:11 INFO - docopt == 0.6.1 04:06:11 INFO - manifestparser == 1.1 04:06:11 INFO - mozInstall == 1.12 04:06:11 INFO - mozcrash == 0.16 04:06:11 INFO - mozdebug == 0.1 04:06:11 INFO - mozdevice == 0.48 04:06:11 INFO - mozfile == 1.2 04:06:11 INFO - mozhttpd == 0.7 04:06:11 INFO - mozinfo == 0.9 04:06:11 INFO - mozleak == 0.1 04:06:11 INFO - mozlog == 3.1 04:06:11 INFO - moznetwork == 0.27 04:06:11 INFO - mozprocess == 0.22 04:06:11 INFO - mozprofile == 0.28 04:06:11 INFO - mozrunner == 6.11 04:06:11 INFO - mozscreenshot == 0.1 04:06:11 INFO - mozsystemmonitor == 0.0 04:06:11 INFO - moztest == 0.7 04:06:11 INFO - mozversion == 1.4 04:06:11 INFO - psutil == 3.1.1 04:06:11 INFO - requests == 1.2.3 04:06:11 INFO - wsgiref == 0.1.2 04:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:11 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:11 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 04:06:11 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 04:06:11 INFO - Using env: {'DISPLAY': ':0', 04:06:11 INFO - 'HOME': '/home/cltbld', 04:06:11 INFO - 'LANG': 'en_US.UTF-8', 04:06:11 INFO - 'LANGUAGE': 'en_US:en', 04:06:11 INFO - 'LOGNAME': 'cltbld', 04:06:11 INFO - 'MAIL': '/var/mail/cltbld', 04:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:11 INFO - 'MOZ_NO_REMOTE': '1', 04:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:11 INFO - 'NO_EM_RESTART': '1', 04:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:11 INFO - 'PWD': '/builds/slave/test', 04:06:11 INFO - 'SHELL': '/bin/bash', 04:06:11 INFO - 'SHLVL': '1', 04:06:11 INFO - 'TERM': 'linux', 04:06:11 INFO - 'TMOUT': '86400', 04:06:11 INFO - 'USER': 'cltbld', 04:06:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:11 INFO - '_': '/tools/buildbot/bin/python'} 04:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:11 INFO - Cleaning up... 04:06:11 INFO - Return code: 0 04:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:11 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:11 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 04:06:11 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 04:06:11 INFO - Using env: {'DISPLAY': ':0', 04:06:11 INFO - 'HOME': '/home/cltbld', 04:06:11 INFO - 'LANG': 'en_US.UTF-8', 04:06:11 INFO - 'LANGUAGE': 'en_US:en', 04:06:11 INFO - 'LOGNAME': 'cltbld', 04:06:11 INFO - 'MAIL': '/var/mail/cltbld', 04:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:11 INFO - 'MOZ_NO_REMOTE': '1', 04:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:11 INFO - 'NO_EM_RESTART': '1', 04:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:11 INFO - 'PWD': '/builds/slave/test', 04:06:11 INFO - 'SHELL': '/bin/bash', 04:06:11 INFO - 'SHLVL': '1', 04:06:11 INFO - 'TERM': 'linux', 04:06:11 INFO - 'TMOUT': '86400', 04:06:11 INFO - 'USER': 'cltbld', 04:06:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:11 INFO - '_': '/tools/buildbot/bin/python'} 04:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:11 INFO - Downloading/unpacking jsonschema 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:13 INFO - warning: no files found matching '*.txt' 04:06:13 INFO - no previously-included directories found matching 'build' 04:06:13 INFO - no previously-included directories found matching 'dist' 04:06:13 INFO - no previously-included directories found matching '.git*' 04:06:13 INFO - Installing collected packages: jsonschema, functools32 04:06:13 INFO - Running setup.py install for functools32 04:06:13 INFO - warning: no files found matching '*.txt' 04:06:13 INFO - no previously-included directories found matching 'build' 04:06:13 INFO - no previously-included directories found matching 'dist' 04:06:13 INFO - no previously-included directories found matching '.git*' 04:06:13 INFO - Successfully installed jsonschema functools32 04:06:13 INFO - Cleaning up... 04:06:13 INFO - Return code: 0 04:06:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 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 0x7f6c1b9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, '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': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:13 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 04:06:13 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 04:06:13 INFO - Using env: {'DISPLAY': ':0', 04:06:13 INFO - 'HOME': '/home/cltbld', 04:06:13 INFO - 'LANG': 'en_US.UTF-8', 04:06:13 INFO - 'LANGUAGE': 'en_US:en', 04:06:13 INFO - 'LOGNAME': 'cltbld', 04:06:13 INFO - 'MAIL': '/var/mail/cltbld', 04:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:13 INFO - 'MOZ_NO_REMOTE': '1', 04:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:13 INFO - 'NO_EM_RESTART': '1', 04:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:13 INFO - 'PWD': '/builds/slave/test', 04:06:13 INFO - 'SHELL': '/bin/bash', 04:06:13 INFO - 'SHLVL': '1', 04:06:13 INFO - 'TERM': 'linux', 04:06:13 INFO - 'TMOUT': '86400', 04:06:13 INFO - 'USER': 'cltbld', 04:06:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:13 INFO - '_': '/tools/buildbot/bin/python'} 04:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:14 INFO - Downloading/unpacking flake8 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:16 INFO - no previously-included directories found matching 'docs/_build' 04:06:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:16 INFO - Running setup.py install for pep8 04:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:16 INFO - no previously-included directories found matching 'docs/_build' 04:06:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:16 INFO - Cleaning up... 04:06:16 INFO - Return code: 0 04:06:16 INFO - Running post-action listener: _resource_record_post_action 04:06:16 INFO - Running post-action listener: _start_resource_monitoring 04:06:16 INFO - Starting resource monitoring. 04:06:16 INFO - ##### 04:06:16 INFO - ##### Running install step. 04:06:16 INFO - ##### 04:06:16 INFO - Running pre-action listener: _resource_record_pre_action 04:06:16 INFO - Running main action method: install 04:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:16 INFO - Reading from file tmpfile_stdout 04:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:17 INFO - Reading from file tmpfile_stdout 04:06:17 INFO - Output received: 04:06:17 INFO - Usage: mozinstall [options] installer 04:06:17 INFO - Options: 04:06:17 INFO - -h, --help show this help message and exit 04:06:17 INFO - -d DEST, --destination=DEST 04:06:17 INFO - Directory to install application into. [default: 04:06:17 INFO - "/builds/slave/test"] 04:06:17 INFO - --app=APP Application being installed. [default: firefox] 04:06:17 INFO - mkdir: /builds/slave/test/build/application 04:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:06:32 INFO - Reading from file tmpfile_stdout 04:06:32 INFO - Output received: 04:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:32 INFO - Running post-action listener: _resource_record_post_action 04:06:32 INFO - ##### 04:06:32 INFO - ##### Running run-tests step. 04:06:32 INFO - ##### 04:06:32 INFO - Running pre-action listener: _resource_record_pre_action 04:06:32 INFO - Running main action method: run_tests 04:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:32 INFO - Python 2.7.3 04:06:32 INFO - Return code: 0 04:06:32 INFO - grabbing minidump binary from tooltool 04:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:32 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 0x1c803d0>, '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 0x1bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bec360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:06:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:32 INFO - Return code: 0 04:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:33 INFO - Return code: 0 04:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:06:33 INFO - Using env: {'DISPLAY': ':0', 04:06:33 INFO - 'HOME': '/home/cltbld', 04:06:33 INFO - 'LANG': 'en_US.UTF-8', 04:06:33 INFO - 'LANGUAGE': 'en_US:en', 04:06:33 INFO - 'LOGNAME': 'cltbld', 04:06:33 INFO - 'MAIL': '/var/mail/cltbld', 04:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:33 INFO - 'MOZ_NO_REMOTE': '1', 04:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:33 INFO - 'NO_EM_RESTART': '1', 04:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:33 INFO - 'PWD': '/builds/slave/test', 04:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:33 INFO - 'SHELL': '/bin/bash', 04:06:33 INFO - 'SHLVL': '1', 04:06:33 INFO - 'TERM': 'linux', 04:06:33 INFO - 'TMOUT': '86400', 04:06:33 INFO - 'USER': 'cltbld', 04:06:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665', 04:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:33 INFO - '_': '/tools/buildbot/bin/python'} 04:06:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:06:34 INFO - mozversion application_buildid: 20160120024518 04:06:34 INFO - mozversion application_changeset: 7f066e9a778b6c0b627204d24b046ccd9ab9e613 04:06:34 INFO - mozversion application_display_name: Nightly 04:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:34 INFO - mozversion application_name: Firefox 04:06:34 INFO - mozversion application_remotingname: firefox 04:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:06:34 INFO - mozversion application_vendor: Mozilla 04:06:34 INFO - mozversion application_version: 46.0a1 04:06:34 INFO - mozversion platform_buildid: 20160120024518 04:06:34 INFO - mozversion platform_changeset: 7f066e9a778b6c0b627204d24b046ccd9ab9e613 04:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:06:34 INFO - mozversion platform_version: 46.0a1 04:06:34 INFO - using testdate: 1453291594 04:06:34 INFO - actual date: 1453291594 04:06:34 INFO - starting webserver on 'localhost:46812' 04:06:34 INFO - SUITE-START | Running 3 tests 04:06:34 INFO - TEST-START | dromaeo_css 04:06:34 INFO - operating with platform_type : linux_ 04:06:34 INFO - Initialising browser for dromaeo_css test... 04:06:34 INFO - TEST-INFO | started process 22944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA_cHC3/profile http://localhost:46812/getInfo.html) 04:06:37 INFO - PROCESS | 22944 | -- checkerboarding starts below -- 04:06:37 INFO - PROCESS | 22944 | RENDERTRACE 0.035034 rect red 0 0 1024 768 // viewport 04:06:37 INFO - PROCESS | 22944 | RENDERTRACE 324.696 rect brown 0 0 1024 768 // page 04:06:37 INFO - PROCESS | 22944 | RENDERTRACE 324.73 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 04:06:37 INFO - PROCESS | 22944 | Checkerboarded for 1 frames (332.714 ms), 786432 peak, 10439 severity. 04:06:38 INFO - PROCESS | 22944 | 04:06:38 INFO - PROCESS | 22944 | (process:23026): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:38 INFO - PROCESS | 22944 | __metrics Screen width/height:1600/1200 04:06:38 INFO - PROCESS | 22944 | colorDepth:24 04:06:38 INFO - PROCESS | 22944 | Browser inner width/height: 1024/697 04:06:38 INFO - PROCESS | 22944 | __metrics 04:06:39 INFO - PROCESS | 22944 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:06:40 INFO - TEST-INFO | 22944: exit 0 04:06:40 INFO - Browser initialized. 04:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:40 INFO - TEST-INFO | started process 23075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA_cHC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:40 INFO - PROCESS | 23075 | -- checkerboarding starts below -- 04:06:40 INFO - PROCESS | 23075 | RENDERTRACE 0.030861 rect red 0 0 10 10 // viewport 04:06:40 INFO - PROCESS | 23075 | RENDERTRACE 83.217 rect brown 0 0 10 10 // page 04:06:40 INFO - PROCESS | 23075 | RENDERTRACE 83.2414 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:06:40 INFO - PROCESS | 23075 | Checkerboarded for 1 frames (83.4339 ms), 100 peak, 1 severity. 04:06:41 INFO - PROCESS | 23075 | 04:06:41 INFO - PROCESS | 23075 | (process:23134): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:52 INFO - PROCESS | 23075 | RSS: Main: 150188032 04:06:52 INFO - PROCESS | 23075 | 04:07:41 INFO - PROCESS | 23075 | 1453291661656 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:09:52 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46812/tests/dromaeo/cssquery-ext.html) 04:09:53 INFO - PROCESS | 23075 | RSS: Main: 154140672 04:09:53 INFO - PROCESS | 23075 | 04:12:55 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-ext.html (next: http://localhost:46812/tests/dromaeo/cssquery-jquery.html) 04:12:56 INFO - PROCESS | 23075 | RSS: Main: 153477120 04:12:56 INFO - PROCESS | 23075 | 04:15:58 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46812/tests/dromaeo/cssquery-mootools.html) 04:15:58 INFO - PROCESS | 23075 | RSS: Main: 151134208 04:15:58 INFO - PROCESS | 23075 | 04:19:00 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46812/tests/dromaeo/cssquery-prototype.html) 04:19:01 INFO - PROCESS | 23075 | RSS: Main: 149041152 04:19:01 INFO - PROCESS | 23075 | 04:22:03 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46812/tests/dromaeo/cssquery-yui.html) 04:22:04 INFO - PROCESS | 23075 | RSS: Main: 151240704 04:22:04 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | Cycle 1(1): loaded http://localhost:46812/tests/dromaeo/cssquery-yui.html (next: http://localhost:46812/tests/dromaeo/cssquery-dojo.html) 04:25:07 INFO - PROCESS | 23075 | RSS: Main: 153178112 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | __start_tp_report 04:25:07 INFO - PROCESS | 23075 | _x_x_mozilla_page_load 04:25:07 INFO - PROCESS | 23075 | _x_x_mozilla_page_load_details 04:25:07 INFO - PROCESS | 23075 | |i|pagename|runs| 04:25:07 INFO - PROCESS | 23075 | |0;dojo.html;2615.1239334822835;2620.960685589716;2649.8675066246697;2650.9469810603778;2662.1214999050308;4436.29019356903;4441.977790111049;4459.777011149442;4478.91042179157;4519.638428925687;4523.2762757958735;4568;4571.108633816407;4636.3740894979255;4638.956234847166;3964.8612298569556;4132.483439570054;4216.683748718843;4227.196832601811;4299.656027517807;4216.177845320149;4237.216115018731;4259;4271.487421509423;4311.913761724763;4081.673466122703;4144.48193975753;4162.708610397273;4203.684723645708;4216.85241016566;4183.247015537202;4183.477065366829;4212.220739163234;4225.408442818008;4227;4101.815418306153;4178.540360560336;4179.393987871742;4186.183694179636;4203;4345.739255644671;4427.114577084596;4461.598456138963;4474.53017433168;4502.707324023961;4852.660313778037;4875.634327425421;4876.853694389174;4883.243097319921;4885.413750349945;4777.856664300042;4848.709077455329;4913.656044076916;4924.113659541281;4944.629152813553;4476.216662084123;4532.478764942008;4536.138133754576;4573.794179261941;4580.450345958439;4951.529604687549;4979.775910084055;4986.426560945538;4991.500849915052;5007.69953802773;4669.789859456333;4739.810407583658;4745.501722319107;4788.257820037899;4838.95161048385;4863.10032643962;4876.926846097312;4883.34074899891;4887.315775791392;4929.112759703288;4825.734584597811;4826.493218212107;4835.274708793709;4836.395450568679;4848.0788650156355;4657.953420465819;4751.691140075953;4761.047790441926;4815.422149342031;4831.106245344622;4078.57174996627;4079.3065178919655;4091.365838295069;4100.220958017967;4101.26177288085;3555.9111022224133;3561.821908904544;3571.9641304021543;3594.748367614242;3610.241849211695;4158.688098392633;4216.51510076339;4237.343211802114;4291.356296555542;4317.460317460317;4730.266808644666;4731.455882573479;4745.715257084586;4753.643476739258;4770.833020844254;4140.648044916215;4143.81352839123;4150.605692459211;4175.185838761412;4187.937180942288;4210.852620158341;4263.509696384894;4291.227579035741;4308.353746937984;4339.392485052095;4612.215923293048;4619.099275641218;4624.514425985358;4630.4443466784205;4677.041206552649;4755.6195504358875;4853.344798452164;4854.077725232195;4856.295837103529;4906.092372911023;4564.543545645409;4567.977160114311;4591.150637132141;4624.02895391958;4639.884002899955;4786.880327991688;4800.879978000578;4803.255495398219;4814.229723244264;4846.297286893451;4764.737939413366;4849.781759820887;4897.118518666674;4900.656954013328;4917.704937703749;4654.837080702159;4655.976720116378;4680.578747912704;4685.250359942393;4725.834595789131;4644.419447569054;4648.070385922897;4651.186042442491;4651.209294419889;4694.483606803181;4473.530279320625;4524.751138687404;4541.886452838706;4566.725996440225;4580.862574122782;4734.360861283821;4753.524647535219;4754.952450475451;4767.523247675204;4783.928241076317;4652.767361631973;4656.092062047868;4659.347691323285;4665.906681866276;4697.318888761179 04:25:07 INFO - PROCESS | 23075 | |1;ext.html;484.76973437617113;488.84845697833674;495.66542583755955;524.8687828042989;552.7480257217401;24907;25604.35989100271;32538;32613.51079733806;32692.509612355832;36081;36522.26955460896;36642.083947901316;36708.81645591775;36738.81630591843;7641.35048520875;7843.33331666809;7847.529148251095;7850.960745196266;7860.803479913019;7471.066116735408;7606.657700403495;7608.961955190216;7610.1628820829665;7626.504277221963;7767.184445633212;7838.176991415876;7843.372530197599;7853.725119620814;7859.331956783681;7749.728759493419;7775.844483110306;7776.688932442696;7806.921930780704;7823.569703666296;7683.961580192119;7904.960475197645;7939.5633240171765;7953.602319883983;7973.32226760726;36383.272334553425;37074.81462592697;37113.25773484542;37126;37223.25553488915;2856.3144845237202;2857.6713677927096;2950.822950622948;3332.4334863073095;3337.749668774827;27373.589396159074;27466;27633.171004869888;27860.860695696392;27872;3450.6721861423125;3493.0917961329983;3496.4230901901155;3501.6148223695373;3550.7692000019915;197707;199168;199439;200010;200081.99959000258;46900;47579.28631070536;53152.20271695928;53335.19997200045;53878;49954.50045499499;49988.500114999115;50066.749666252166;50211.49788502068;50353.74823125861;12333.444994975247;12426.689332766573;12469.812952805714;12483.93758031204;12489.12576119681;9454.669086581936;9568.61725530971;9582.712518624452;9608.711738647851;9612.711618651452;17788.199531021135;18241.908790455964;18760.437186884414;18766;18870.52823679419;6796.218434880052;6990.26602206761;7042.330978557029;7123.394511466479;7145.392641625416;856.39624065034;869.6516423992371;919.7240827751648;956.7082039977735;963.9878127965608;26064.869675651502;26088.60867086995;26248.60627090595;26260.212193634223;26264;859.6647307550061;940.1022023967095;940.5673390240567;955.0306438964457;960.7406000379858;13761.931190344185;13956.581302560939;13960.58118256454;14232.146071235551;14506.347214375379;241765;242109.36835947476;243211;244589;245271;44947.55052449499;44952;45072.54927450683;45075.549244507136;45113.77443112763;1170.1750266062406;1199.0527483288279;1200.6278053803348;1210.842590463234;1216.1365430544236;26210.213693589223;26455.074072407373;26596.867015664797;26744.59883101794;26801.597976030764;39767.005824853455;40144.79927600343;40297.395539067526;40437.19125617413;40496.595034050464;232240;232608;233265;234214;234686;27890.86054569714;28542.714572854005;28935.421291574472;28994.565081524215;29019.85490072536;33463;33795.83102084474;34455.138621534665;34519;36367.818160909024;30702.539461907643;31456.213594660316;31623.367532648757;31888.202794930312;32161.678383216804;31140.532892006184;31200.207655292106;31521.054368368987;31550.36899262048;31553.684463155074;31065.53401698931;31199;31395.37209255848;31446;31458.685413145577;26819.32951676224;29798.25504362408;30446.543301850932;30595.54106688357;30730.539041914835;21295.8935205323;22029.779702202773;22684.432889177904;22942.311730648107;22988.540229195656 04:25:07 INFO - PROCESS | 23075 | |2;jquery.html;320.5032200089861;324.7077630132879;327.8442739698643;339.6501603348552;344.6467370944783;14615.707685846277;14713.926430367834;15196.31616577254;15315.540533783991;15366.539003829903;9942.10521053105;10202.74493137672;12163.452644631012;15067.62330941727;15077.396904123849;4482.843100491484;4685.9062818743605;4691.0617876424685;4704.106219818241;4859.538343857328;4799.928001079987;4894.877628059309;4901.632377571678;4929.580985616227;5055.949440505603;4688.789004494806;4886.096072226632;4899.167141585921;5618.438156184389;5653.773849046033;4811.158047341736;4892.951070489303;4908.460069392364;4937.5556199942;5259.15853463444;5045.571126454256;5069.239614057884;5072.061668591323;5073.695578265316;5081.542661160476;10893.128549716082;11000.669979900616;11386.462827518344;11397.259178153394;11398.202125851194;1765.1086201468177;1781.5278951077976;1787.49950013995;1873.4566975577065;1936.2932529626585;8400.747977560623;9287.931887832918;11306.717332066764;11561.132915031407;11624.94187529057;1642.244567498952;1652.0665823809509;1656.6769479951415;1698.8962648168292;1701.0559139677473;46427.76786116081;47187;47306.76346618245;48052.51947480515;48345.27482087771;9226;9458.763530911783;9501.762455938657;9510.09654082861;9523.857142142873;11915;11922.523099076114;11982.16124871268;12023.076307790887;12055.939720301343;6575.80272591823;6648.268690444047;6664.400203981665;6698.363655452724;6708.396244338033;6204.937950620526;6226.097215903668;6234.75060997555;6256.249250090018;6303.684815759194;3972.741771784825;4013.237484877864;4013.3578627420056;4026.4362989180954;4033.979830100831;1574.8188958269716;1576.8896177267711;1682.142107525171;1692.1031853117868;1707.581642497596;814.8288859339486;832.7085520068049;904.9049849765811;929.4609126706493;945.7021038372891;14785.334659940328;14807.481738139113;14876.330565124596;14945.103293802407;15177.848221517865;787.2363807107212;830.8670612702059;846.386369881843;865.1737590600961;876.7019213467452;7782.221777822286;8583.871241931376;8607.139286071468;8770.25452836516;8897.332700047522;441049;446732;448766;454017;454177;60136.69931650314;61532.38467615356;62717.37282627207;62939.370606294266;63693.68153159205;985.0199051943363;1013.4983183324301;1024.2215915903967;1085.0776839686202;1085.3433672627946;13657.180569165881;13676.863231367559;13703.931480342535;13928.651783705489;13981.021328506908;30415.54376684307;30460.84769576138;30649.233769155948;31056.68943310538;31708.365832682757;38383.61616383912;38597.6140238594;39590.60409395869;39640.80179599083;41053.79473102615;3349.547811045575;3524.629913859008;6024.849378765566;6468.2561505427475;6612.900806488003;6741.797746067626;9357.812843743222;9477.715668529956;9555.952220238854;9876.308658393844;8130.918690813016;8244.422890397855;8732.34507411934;8745.256653184551;8809.867851982097;8446.746597602081;8829.472720214248;8929.241014513838;9615.375000624937;9634.518274086127;8865.512396818236;8952.955235223782;9036.412633178823;9165.358424910191;9261.72214833556;6493.383128602775;6867.450603951572;6955.061066755923;6979.232284448605;7003.789886303419;8474.703385381483;8659.956700216459;8690.435121717068;8928.241099506615;8949.463032218087 04:25:07 INFO - PROCESS | 23075 | |3;mootools.html;1330.0091431883247;1335.9332033398327;1401.5374926274324;1636.026564194304;1641.2614323554403;6054.666993315366;6190.102435146901;6787.66061696915;6986.196587392451;6989.510734248598;6532.608043517381;6695.732170713178;6763.66181690916;6777.390034896858;6807.72769089237;2030.2995466564048;2053.3634573282256;2071.109422948132;2072.626927153112;2075.6575165097815;2027.290448343083;2043.2644248070683;2052.3842847145797;2060.9587808243828;2063.998960504154;2025.908834102469;2026.402211347656;2029.9594008119902;2042.6935959606103;2048.8770673759623;2046.5292982613933;2046.6827641715558;2046.9385918422472;2049.1291201239487;2062.876227426359;2037.2665840297482;2048.805363490466;2066.9896650516803;2068.069368784053;2070.244360808294;7002.7899163025195;7034.050403195605;7050.118735158106;7058.894116588255;7085.964570177116;3926.2147570486018;4014.0767623446773;4032;4037.0714735610973;4040.4141399496907;2683.5437975544205;2694.4745774573967;2717.7418145276165;2775.1951933939135;2783.7772978161697;833.0378412933072;855.6534603485599;861.6553378648528;863.3999370437548;899.5682072605186;9506.904930950672;9511;9524.904750952472;9537;9589.136977671973;3659.780413175218;3669.376206044979;3709.795961222159;3711.536057992751;3715.758475699071;8010.19898010206;8061.556614386148;8062.395320350997;8172;8178.795530111675;3967.107400834847;3974.682025437958;3978.741381810173;3979.7612143271494;4000;3139.9058028259187;3217.0670505553126;3605.9278814423565;3661.212839239523;3674.9816250918575;3250.398676244902;3305.834708264625;3325.717314028335;3331.133905184621;3338.3657105149946;1034.6378767431338;1039.3815679670583;1042.4475028235047;1044.070777008463;1048.2871647279924;967.6081187119228;1095.0746619106842;1106.5241945963312;1115.6876074699098;1123.2025262064026;6391.712372943229;6417.903731444032;6457.160569125984;6467.191601049869;6469.805905822833;1002.0931057393071;1024.1704219582161;1032.442481060234;1035.6219979707353;1048.5019615682643;4850.902981940412;4875.317455556225;4905.460399356068;4906.435759887588;4912.361393018885;7797;8008.119106898236;8232.794180145425;8262.297704695047;8275.255227029596;7810.218978102144;7822.413319001098;7827.92172078272;7858.292753652198;7886.881696774438;6295.527835412362;6332.240131184288;6373.235211774617;6373.776917807854;6407.647579383085;6172.259328880563;6275.403836635513;6337.429631333202;6346.555741098079;6353.555251132561;7170.856582868209;7211.350978411968;7251.419886408969;7391.113066432063;7392.22381649919;7414.480986331121;7464.6267686614365;7514.62426878643;7556.622168891424;7590.506617069873;5517.282753242052;5670.347909990239;5975.282966044103;6124.356942520971;6150.753969841336;6360.713767880549;6424.678766061772;6443.484521238196;6483.384078512534;6496.740130394731;6109.6334219945165;6279.309275979547;6309.211348581427;6338.366163383625;6387.105805187184;6180.598261113013;6249.812505624838;6285.497160227263;6342.90485642725;6392.744290228339;6300.054991751274;6316.021016742412;6341.682915854097;6341.8731625368155;6351.110844481684;5839.532837372915;5846.795362162304;5871.530277577869;5874.647521148745;5882.647041177543;5746.798862039808;5794.449527294901;5827.3881242470625;5900.085486749561;5908.734106965111 04:25:07 INFO - PROCESS | 23075 | |4;prototype.html;300.21493793729394;302.9984850075751;309.489342584735;310.0357886971519;310.5652087078092;5568.582356323272;5607.355154157273;5636.689982050985;5745.339285982108;5782.24830771999;5553.694546799924;5625.46558076982;5628.155776633507;5641.323041235048;5646.040173170561;4044.1911617676437;4122.299209134454;4239.215745087154;4250.596193361625;4256.893577660568;4166.062635906927;4301.225779359714;4311.935320970188;4323.329883868006;4334.241507736149;4205.306124489471;4217.283061879488;4222.472190976128;4231.957680423203;4235.57644235577;4221.0291632924445;4221.366794980747;4231.87304380869;4232.25935461293;4235.57644235577;3676.1544844685873;3680.300742858875;3685.5577330720216;3686.502322186497;3696.1129328961124;5271.42014378418;5296.576273898079;5352.277442545245;5355.169948657965;5371.57027437804;4851.539103785135;4880.731559764212;4894.804207831682;4897.2898929655;4907.950920490785;5820.156077368758;5833.125031245305;5834.6790926499025;5837.532997360201;5862.267216597926;4021.879343619696;4022.859199928018;4027.436158937751;4028.133951200506;4032.1330913853662;5876.882462350729;6123.234595675541;6129.448349648508;6161.568690191689;6171.56799024073;4102.630763231324;4113.197926404382;4116.485439320085;4131.29767939451;4143.02638879863;4198.916021679549;4206.978965105216;4207.305794543866;4208.579142085767;4211.515675697273;4808.61531077513;4826.58973987208;4844.491328410537;4844.95155048452;4852.975735121302;5698.059820129715;5774;5813.186153938452;5818.970905145447;5820.330661973842;1454.5054681408371;1462.7732701431296;1465.5749832548654;1469.426923499836;1469.4856800120085;971.6890595009529;978.6134476881592;985.3890587835588;985.7141428985657;987.2644879564626;5119.360079990001;5121.103806833864;5123.205903085028;5144.408393034774;5152.098382782998;5978.5814992950945;6053.697315134314;6124.448799607968;6128.846778830476;6146.262448506208;5134.229865520202;5135.35808023997;5152.355955505562;5164.14791559396;5177.559907407837;3267.591551056118;3287.7862938908893;3302.3890580242733;3306.3883181611477;3316.336732653479;5694.088945768657;5776.537876969833;5810.738516766755;5812.738426770806;5813.331466881278;6320.747170113144;6326.177596912464;6334.208223972004;6338.176037115146;6340.461060809791;5820.35976042635;5858.091995740667;5869.853253668607;5883.470487656132;5888.764449422061;5935.228420305332;6070.969645151746;6107.786227482017;6109.938900611115;6146.262448506208;5942.049272116441;5964.045752679551;5978.252718410199;5986.311574169026;6011.729472173675;5791.391903850035;5808.912866306924;5817.680027598522;5825.446582574648;5831.825045248649;4084.7140700151895;4121.855735049259;4122.690798190088;4125.463689720437;4129.15352352773;5873.970630146993;6106.847328816815;6127.908081378694;6136.478399336106;6142.14010038586;5903.940960590339;5930.733117009659;5962.582619216613;5969.761209551743;5980.192673988956;5888.587798854039;5905.055191169392;5917.378675239038;5921.585489015728;5928.081147422156;5712.857178570569;5786.479216870502;5801.071828507418;5801.883962320646;5850.7074646266665;5850.7074646266665;5920.111983202554;5948.702564871825;5958.851028724316;5965.791197308247;5632.324121105494;5784.161296612052;5787.681677507778;5789.507891829242;5792.333881603501 04:25:07 INFO - PROCESS | 23075 | |5;yui.html;648.5840245087049;653.875763604915;661.1108059659757;716.1978583985937;763.7899577616158;10691.78616427671;10869.076128529065;10901.890981090197;10921.726956826084;10934.343939363634;10115.291929564934;10178.541965611546;10189.643362482315;10203.642872499464;10226.897731022687;577.9335376431723;590.8493334199773;719.6437763307144;736.6905899522213;738.656524716007;732.8644200822838;733.413269384493;735.7645553422907;737.870872597296;738.9852202955938;757.6211894052974;760.4524742185645;762.1730422491603;762.8169239382564;762.9427792915526;758.7382353088203;758.9316961473467;759.6277823866266;760.0803028335721;760.6158889760691;567.1096378685465;567.5402923631872;567.7303280941561;568.7497501099502;569.7236840132532;10566.471676416148;10605.84091238632;10608.522616482276;10623.681289561326;10640.840387394195;11196.496157672924;11623.418829058513;11656.358900260482;11664.125190610654;11778.823317650242;9439.764005899839;9478.810423791485;9569.617215311378;9582.856257156078;9589.808203835884;3215.26049008727;3236;3254.7721659483846;3265.2816380396275;3339.782914110575;42083;42109.36835947433;42694;42719.57280427187;42913.14173716508;8630.309575233967;8687;8774.780630484289;8814.118588141135;8820.250278726251;14634.926825365805;14675.486357977634;14811.703765924836;14854.2572871356;14906.105633662015;6066.272047354346;6163.9383606164265;6387.776427825004;6464.191976003;6646.6676666166495;3549.5563054618174;3568.1971556399603;3629.2378600494194;3633.0372451300427;3634.2186429917697;2556.9744302556737;2574.6395504629368;2585.974140258611;2587.236765154284;2599.4671092426006;465.36012982149543;467.4997752404962;469.577380357674;474.3690891114809;477.315052899084;442.16651611712155;481.5882420530466;524.1587252459823;532.9733513324318;535.3014316317166;7001.054857594159;7126.251743566851;7763.4953728007495;7797.259260370256;8017.959910200411;445.3320019970045;470.54122230824674;529.9602529810203;530.3079481276893;553.6346011632303;3405.9148521287166;3587.5336206293014;3606.13452771333;3745.194783121642;3782.583915769263;45143;45359.54640453553;45364.319535206996;45550.31674524885;45563.31655025177;40570.59429405727;41173.588264116974;41381.37927931084;41482;42016;36923.26153476915;37971.81014094912;37994.810025950246;38703.22593548169;38748.225035499694;7136.964315178391;7276.05411296528;7300.233475484997;7355.77932662021;7363.889541656987;28494.43011139807;28637.28406789847;29060.56409153822;29422.264443389085;29555.261118472212;33787.662123379436;33914.98255052352;35840.82079589585;37835.81082094572;37971.240575188895;8931.776705582412;9054.185123338932;9216.03231660666;9277.304202184729;9414.811703766023;9482.478463684563;9608.663696770858;9655.034496550288;9874.506274686093;9969.950150249202;9365.812683746422;9369.203617692572;9422.670206542738;9470.810583788423;9865.260105491972;9021.413608115452;9222.308326875376;9239.122283383067;9241.306901982512;9604.615815367308;8647.135286471303;9267.258619310303;9312.115349041831;9567.138957493858;9627.951860240653;7721.53670779755;7905.01187351581;7976.9202307976175;8208.747514910538;8241.052278987992;8256.669733210845;8332.375071869512;8355.331573474228;8373.665053397795;8483.95758021206 04:25:07 INFO - PROCESS | 23075 | __end_tp_report 04:25:07 INFO - PROCESS | 23075 | __start_cc_report 04:25:07 INFO - PROCESS | 23075 | _x_x_mozilla_cycle_collect,329 04:25:07 INFO - PROCESS | 23075 | __end_cc_report 04:25:07 INFO - PROCESS | 23075 | __startTimestamp1453292707305__endTimestamp 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | ------- Summary: start ------- 04:25:07 INFO - PROCESS | 23075 | Number of tests: 6 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#0] dojo.html Cycles:165 Average:4478.15 Median:4619.10 stddev:453.39 (9.8%) stddev-sans-first:430.58 04:25:07 INFO - PROCESS | 23075 | Values: 2615.1 2621.0 2649.9 2650.9 2662.1 4436.3 4442.0 4459.8 4478.9 4519.6 4523.3 4568.0 4571.1 4636.4 4639.0 3964.9 4132.5 4216.7 4227.2 4299.7 4216.2 4237.2 4259.0 4271.5 4311.9 4081.7 4144.5 4162.7 4203.7 4216.9 4183.2 4183.5 4212.2 4225.4 4227.0 4101.8 4178.5 4179.4 4186.2 4203.0 4345.7 4427.1 4461.6 4474.5 4502.7 4852.7 4875.6 4876.9 4883.2 4885.4 4777.9 4848.7 4913.7 4924.1 4944.6 4476.2 4532.5 4536.1 4573.8 4580.5 4951.5 4979.8 4986.4 4991.5 5007.7 4669.8 4739.8 4745.5 4788.3 4839.0 4863.1 4876.9 4883.3 4887.3 4929.1 4825.7 4826.5 4835.3 4836.4 4848.1 4658.0 4751.7 4761.0 4815.4 4831.1 4078.6 4079.3 4091.4 4100.2 4101.3 3555.9 3561.8 3572.0 3594.7 3610.2 4158.7 4216.5 4237.3 4291.4 4317.5 4730.3 4731.5 4745.7 4753.6 4770.8 4140.6 4143.8 4150.6 4175.2 4187.9 4210.9 4263.5 4291.2 4308.4 4339.4 4612.2 4619.1 4624.5 4630.4 4677.0 4755.6 4853.3 4854.1 4856.3 4906.1 4564.5 4568.0 4591.2 4624.0 4639.9 4786.9 4800.9 4803.3 4814.2 4846.3 4764.7 4849.8 4897.1 4900.7 4917.7 4654.8 4656.0 4680.6 4685.3 4725.8 4644.4 4648.1 4651.2 4651.2 4694.5 4473.5 4524.8 4541.9 4566.7 4580.9 4734.4 4753.5 4755.0 4767.5 4783.9 4652.8 4656.1 4659.3 4665.9 4697.3 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#1] ext.html Cycles:180 Average:37948.66 Median:33629.42 stddev:58765.45 (174.7%) stddev-sans-first:58862.98 04:25:07 INFO - PROCESS | 23075 | Values: 484.8 488.8 495.7 524.9 552.7 24907.0 25604.4 32538.0 32613.5 32692.5 36081.0 36522.3 36642.1 36708.8 36738.8 7641.4 7843.3 7847.5 7851.0 7860.8 7471.1 7606.7 7609.0 7610.2 7626.5 7767.2 7838.2 7843.4 7853.7 7859.3 7749.7 7775.8 7776.7 7806.9 7823.6 7684.0 7905.0 7939.6 7953.6 7973.3 36383.3 37074.8 37113.3 37126.0 37223.3 2856.3 2857.7 2950.8 3332.4 3337.7 27373.6 27466.0 27633.2 27860.9 27872.0 3450.7 3493.1 3496.4 3501.6 3550.8 197707.0 199168.0 199439.0 200010.0 200082.0 46900.0 47579.3 53152.2 53335.2 53878.0 49954.5 49988.5 50066.7 50211.5 50353.7 12333.4 12426.7 12469.8 12483.9 12489.1 9454.7 9568.6 9582.7 9608.7 9612.7 17788.2 18241.9 18760.4 18766.0 18870.5 6796.2 6990.3 7042.3 7123.4 7145.4 856.4 869.7 919.7 956.7 964.0 26064.9 26088.6 26248.6 26260.2 26264.0 859.7 940.1 940.6 955.0 960.7 13761.9 13956.6 13960.6 14232.1 14506.3 241765.0 242109.4 243211.0 244589.0 245271.0 44947.6 44952.0 45072.5 45075.5 45113.8 1170.2 1199.1 1200.6 1210.8 1216.1 26210.2 26455.1 26596.9 26744.6 26801.6 39767.0 40144.8 40297.4 40437.2 40496.6 232240.0 232608.0 233265.0 234214.0 234686.0 27890.9 28542.7 28935.4 28994.6 29019.9 33463.0 33795.8 34455.1 34519.0 36367.8 30702.5 31456.2 31623.4 31888.2 32161.7 31140.5 31200.2 31521.1 31550.4 31553.7 31065.5 31199.0 31395.4 31446.0 31458.7 26819.3 29798.3 30446.5 30595.5 30730.5 21295.9 22029.8 22684.4 22942.3 22988.5 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#2] jquery.html Cycles:180 Average:23421.91 Median:4872.82 stddev:73331.10 (1504.9%) stddev-sans-first:73516.29 04:25:07 INFO - PROCESS | 23075 | Values: 320.5 324.7 327.8 339.7 344.6 14615.7 14713.9 15196.3 15315.5 15366.5 9942.1 10202.7 12163.5 15067.6 15077.4 4482.8 4685.9 4691.1 4704.1 4859.5 4799.9 4894.9 4901.6 4929.6 5055.9 4688.8 4886.1 4899.2 5618.4 5653.8 4811.2 4893.0 4908.5 4937.6 5259.2 5045.6 5069.2 5072.1 5073.7 5081.5 10893.1 11000.7 11386.5 11397.3 11398.2 1765.1 1781.5 1787.5 1873.5 1936.3 8400.7 9287.9 11306.7 11561.1 11624.9 1642.2 1652.1 1656.7 1698.9 1701.1 46427.8 47187.0 47306.8 48052.5 48345.3 9226.0 9458.8 9501.8 9510.1 9523.9 11915.0 11922.5 11982.2 12023.1 12055.9 6575.8 6648.3 6664.4 6698.4 6708.4 6204.9 6226.1 6234.8 6256.2 6303.7 3972.7 4013.2 4013.4 4026.4 4034.0 1574.8 1576.9 1682.1 1692.1 1707.6 814.8 832.7 904.9 929.5 945.7 14785.3 14807.5 14876.3 14945.1 15177.8 787.2 830.9 846.4 865.2 876.7 7782.2 8583.9 8607.1 8770.3 8897.3 441049.0 446732.0 448766.0 454017.0 454177.0 60136.7 61532.4 62717.4 62939.4 63693.7 985.0 1013.5 1024.2 1085.1 1085.3 13657.2 13676.9 13703.9 13928.7 13981.0 30415.5 30460.8 30649.2 31056.7 31708.4 38383.6 38597.6 39590.6 39640.8 41053.8 3349.5 3524.6 6024.8 6468.3 6612.9 6741.8 9357.8 9477.7 9556.0 9876.3 8130.9 8244.4 8732.3 8745.3 8809.9 8446.7 8829.5 8929.2 9615.4 9634.5 8865.5 8953.0 9036.4 9165.4 9261.7 6493.4 6867.5 6955.1 6979.2 7003.8 8474.7 8660.0 8690.4 8928.2 8949.5 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#3] mootools.html Cycles:180 Average:4793.92 Median:5942.01 stddev:2461.85 (41.4%) stddev-sans-first:2454.99 04:25:07 INFO - PROCESS | 23075 | Values: 1330.0 1335.9 1401.5 1636.0 1641.3 6054.7 6190.1 6787.7 6986.2 6989.5 6532.6 6695.7 6763.7 6777.4 6807.7 2030.3 2053.4 2071.1 2072.6 2075.7 2027.3 2043.3 2052.4 2061.0 2064.0 2025.9 2026.4 2030.0 2042.7 2048.9 2046.5 2046.7 2046.9 2049.1 2062.9 2037.3 2048.8 2067.0 2068.1 2070.2 7002.8 7034.1 7050.1 7058.9 7086.0 3926.2 4014.1 4032.0 4037.1 4040.4 2683.5 2694.5 2717.7 2775.2 2783.8 833.0 855.7 861.7 863.4 899.6 9506.9 9511.0 9524.9 9537.0 9589.1 3659.8 3669.4 3709.8 3711.5 3715.8 8010.2 8061.6 8062.4 8172.0 8178.8 3967.1 3974.7 3978.7 3979.8 4000.0 3139.9 3217.1 3605.9 3661.2 3675.0 3250.4 3305.8 3325.7 3331.1 3338.4 1034.6 1039.4 1042.4 1044.1 1048.3 967.6 1095.1 1106.5 1115.7 1123.2 6391.7 6417.9 6457.2 6467.2 6469.8 1002.1 1024.2 1032.4 1035.6 1048.5 4850.9 4875.3 4905.5 4906.4 4912.4 7797.0 8008.1 8232.8 8262.3 8275.3 7810.2 7822.4 7827.9 7858.3 7886.9 6295.5 6332.2 6373.2 6373.8 6407.6 6172.3 6275.4 6337.4 6346.6 6353.6 7170.9 7211.4 7251.4 7391.1 7392.2 7414.5 7464.6 7514.6 7556.6 7590.5 5517.3 5670.3 5975.3 6124.4 6150.8 6360.7 6424.7 6443.5 6483.4 6496.7 6109.6 6279.3 6309.2 6338.4 6387.1 6180.6 6249.8 6285.5 6342.9 6392.7 6300.1 6316.0 6341.7 6341.9 6351.1 5839.5 5846.8 5871.5 5874.6 5882.6 5746.8 5794.4 5827.4 5900.1 5908.7 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#4] prototype.html Cycles:180 Average:4855.81 Median:5634.51 stddev:1454.15 (25.8%) stddev-sans-first:1417.46 04:25:07 INFO - PROCESS | 23075 | Values: 300.2 303.0 309.5 310.0 310.6 5568.6 5607.4 5636.7 5745.3 5782.2 5553.7 5625.5 5628.2 5641.3 5646.0 4044.2 4122.3 4239.2 4250.6 4256.9 4166.1 4301.2 4311.9 4323.3 4334.2 4205.3 4217.3 4222.5 4232.0 4235.6 4221.0 4221.4 4231.9 4232.3 4235.6 3676.2 3680.3 3685.6 3686.5 3696.1 5271.4 5296.6 5352.3 5355.2 5371.6 4851.5 4880.7 4894.8 4897.3 4908.0 5820.2 5833.1 5834.7 5837.5 5862.3 4021.9 4022.9 4027.4 4028.1 4032.1 5876.9 6123.2 6129.4 6161.6 6171.6 4102.6 4113.2 4116.5 4131.3 4143.0 4198.9 4207.0 4207.3 4208.6 4211.5 4808.6 4826.6 4844.5 4845.0 4853.0 5698.1 5774.0 5813.2 5819.0 5820.3 1454.5 1462.8 1465.6 1469.4 1469.5 971.7 978.6 985.4 985.7 987.3 5119.4 5121.1 5123.2 5144.4 5152.1 5978.6 6053.7 6124.4 6128.8 6146.3 5134.2 5135.4 5152.4 5164.1 5177.6 3267.6 3287.8 3302.4 3306.4 3316.3 5694.1 5776.5 5810.7 5812.7 5813.3 6320.7 6326.2 6334.2 6338.2 6340.5 5820.4 5858.1 5869.9 5883.5 5888.8 5935.2 6071.0 6107.8 6109.9 6146.3 5942.0 5964.0 5978.3 5986.3 6011.7 5791.4 5808.9 5817.7 5825.4 5831.8 4084.7 4121.9 4122.7 4125.5 4129.2 5874.0 6106.8 6127.9 6136.5 6142.1 5903.9 5930.7 5962.6 5969.8 5980.2 5888.6 5905.1 5917.4 5921.6 5928.1 5712.9 5786.5 5801.1 5801.9 5850.7 5850.7 5920.1 5948.7 5958.9 5965.8 5632.3 5784.2 5787.7 5789.5 5792.3 04:25:07 INFO - PROCESS | 23075 | 04:25:07 INFO - PROCESS | 23075 | [#5] yui.html Cycles:180 Average:11436.62 Median:567.32 stddev:13028.39 (2296.5%) stddev-sans-first:13039.75 04:25:07 INFO - PROCESS | 23075 | Values: 648.6 653.9 661.1 716.2 763.8 10691.8 10869.1 10901.9 10921.7 10934.3 10115.3 10178.5 10189.6 10203.6 10226.9 577.9 590.8 719.6 736.7 738.7 732.9 733.4 735.8 737.9 739.0 757.6 760.5 762.2 762.8 762.9 758.7 758.9 759.6 760.1 760.6 567.1 567.5 567.7 568.7 569.7 10566.5 10605.8 10608.5 10623.7 10640.8 11196.5 11623.4 11656.4 11664.1 11778.8 9439.8 9478.8 9569.6 9582.9 9589.8 3215.3 3236.0 3254.8 3265.3 3339.8 42083.0 42109.4 42694.0 42719.6 42913.1 8630.3 8687.0 8774.8 8814.1 8820.3 14634.9 14675.5 14811.7 14854.3 14906.1 6066.3 6163.9 6387.8 6464.2 6646.7 3549.6 3568.2 3629.2 3633.0 3634.2 2557.0 2574.6 2586.0 2587.2 2599.5 465.4 467.5 469.6 474.4 477.3 442.2 481.6 524.2 533.0 535.3 7001.1 7126.3 7763.5 7797.3 8018.0 445.3 470.5 530.0 530.3 553.6 3405.9 3587.5 3606.1 3745.2 3782.6 45143.0 45359.5 45364.3 45550.3 45563.3 40570.6 41173.6 41381.4 41482.0 42016.0 36923.3 37971.8 37994.8 38703.2 38748.2 7137.0 7276.1 7300.2 7355.8 7363.9 28494.4 28637.3 29060.6 29422.3 29555.3 33787.7 33915.0 35840.8 37835.8 37971.2 8931.8 9054.2 9216.0 9277.3 9414.8 9482.5 9608.7 9655.0 9874.5 9970.0 9365.8 9369.2 9422.7 9470.8 9865.3 9021.4 9222.3 9239.1 9241.3 9604.6 8647.1 9267.3 9312.1 9567.1 9628.0 7721.5 7905.0 7976.9 8208.7 8241.1 8256.7 8332.4 8355.3 8373.7 8484.0 04:25:07 INFO - PROCESS | 23075 | -------- Summary: end -------- 04:25:07 INFO - PROCESS | 23075 | 04:25:08 INFO - TEST-INFO | 23075: exit 0 04:25:08 INFO - TEST-OK | dromaeo_css | took 1113858ms 04:25:08 INFO - TEST-START | kraken 04:25:08 INFO - operating with platform_type : linux_ 04:25:08 INFO - Initialising browser for kraken test... 04:25:08 INFO - TEST-INFO | started process 23320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL13y0A/profile http://localhost:46812/getInfo.html) 04:25:11 INFO - PROCESS | 23320 | 04:25:11 INFO - PROCESS | 23320 | (process:23391): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:12 INFO - PROCESS | 23320 | __metrics Screen width/height:1600/1200 04:25:12 INFO - PROCESS | 23320 | colorDepth:24 04:25:12 INFO - PROCESS | 23320 | Browser inner width/height: 1024/697 04:25:12 INFO - PROCESS | 23320 | __metrics 04:25:13 INFO - PROCESS | 23320 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:13 INFO - TEST-INFO | 23320: exit 0 04:25:13 INFO - Browser initialized. 04:25:13 INFO - Running cycle 1/1 for kraken test... 04:25:13 INFO - TEST-INFO | started process 23440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL13y0A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:14 INFO - PROCESS | 23440 | -- checkerboarding starts below -- 04:25:14 INFO - PROCESS | 23440 | RENDERTRACE 0.045631 rect red 0 0 10 10 // viewport 04:25:14 INFO - PROCESS | 23440 | RENDERTRACE 17.5748 rect brown 0 0 10 10 // page 04:25:14 INFO - PROCESS | 23440 | RENDERTRACE 17.5973 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:25:14 INFO - PROCESS | 23440 | Checkerboarded for 1 frames (19.6483 ms), 100 peak, 1 severity. 04:25:15 INFO - PROCESS | 23440 | 04:25:15 INFO - PROCESS | 23440 | (process:23497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:25 INFO - PROCESS | 23440 | RSS: Main: 149512192 04:25:25 INFO - PROCESS | 23440 | 04:25:28 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46812/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:29 INFO - PROCESS | 23440 | RSS: Main: 149319680 04:25:29 INFO - PROCESS | 23440 | 04:25:31 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46812/tests/kraken/driver.html?testName=audio-dft) 04:25:32 INFO - PROCESS | 23440 | RSS: Main: 153223168 04:25:32 INFO - PROCESS | 23440 | 04:25:35 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46812/tests/kraken/driver.html?testName=audio-fft) 04:25:36 INFO - PROCESS | 23440 | RSS: Main: 146305024 04:25:36 INFO - PROCESS | 23440 | 04:25:38 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46812/tests/kraken/driver.html?testName=audio-oscillator) 04:25:38 INFO - PROCESS | 23440 | RSS: Main: 147398656 04:25:38 INFO - PROCESS | 23440 | 04:25:41 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:41 INFO - PROCESS | 23440 | RSS: Main: 147591168 04:25:41 INFO - PROCESS | 23440 | 04:25:44 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46812/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:45 INFO - PROCESS | 23440 | RSS: Main: 148054016 04:25:45 INFO - PROCESS | 23440 | 04:25:48 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46812/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:49 INFO - PROCESS | 23440 | RSS: Main: 148402176 04:25:49 INFO - PROCESS | 23440 | 04:25:52 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46812/tests/kraken/driver.html?testName=json-parse-financial) 04:25:52 INFO - PROCESS | 23440 | RSS: Main: 146735104 04:25:52 INFO - PROCESS | 23440 | 04:25:54 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:55 INFO - PROCESS | 23440 | RSS: Main: 149032960 04:25:55 INFO - PROCESS | 23440 | 04:25:57 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:57 INFO - PROCESS | 23440 | RSS: Main: 148467712 04:25:57 INFO - PROCESS | 23440 | 04:25:59 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:00 INFO - PROCESS | 23440 | RSS: Main: 148975616 04:26:00 INFO - PROCESS | 23440 | 04:26:03 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:03 INFO - PROCESS | 23440 | RSS: Main: 148594688 04:26:03 INFO - PROCESS | 23440 | 04:26:06 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:06 INFO - PROCESS | 23440 | RSS: Main: 147771392 04:26:06 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | Cycle 1(1): loaded http://localhost:46812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46812/tests/kraken/driver.html?testName=ai-astar) 04:26:08 INFO - PROCESS | 23440 | RSS: Main: 148697088 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | __start_tp_report 04:26:08 INFO - PROCESS | 23440 | _x_x_mozilla_page_load 04:26:08 INFO - PROCESS | 23440 | _x_x_mozilla_page_load_details 04:26:08 INFO - PROCESS | 23440 | |i|pagename|runs| 04:26:08 INFO - PROCESS | 23440 | |0;ai-astar;118;111;117;116;119;132;116;115;117;116 04:26:08 INFO - PROCESS | 23440 | |1;audio-beat-detection;164;131;165;177;148;155;155;139;176;137 04:26:08 INFO - PROCESS | 23440 | |2;audio-dft;162;164;163;168;162;165;169;163;164;164 04:26:08 INFO - PROCESS | 23440 | |3;audio-fft;75;74;74;153;74;73;74;75;151;74 04:26:08 INFO - PROCESS | 23440 | |4;audio-oscillator;98;97;139;97;98;99;131;98;98;133 04:26:08 INFO - PROCESS | 23440 | |5;imaging-gaussian-blur;110;111;110;110;110;111;111;110;109;109 04:26:08 INFO - PROCESS | 23440 | |6;imaging-darkroom;148;148;148;147;149;150;149;149;148;147 04:26:08 INFO - PROCESS | 23440 | |7;imaging-desaturate;97;99;98;98;96;97;96;97;96;96 04:26:08 INFO - PROCESS | 23440 | |8;json-parse-financial;74;75;76;74;75;74;73;75;78;72 04:26:08 INFO - PROCESS | 23440 | |9;json-stringify-tinderbox;68;69;69;69;69;68;69;70;69;69 04:26:08 INFO - PROCESS | 23440 | |10;stanford-crypto-aes;82;84;84;84;83;84;86;83;85;84 04:26:08 INFO - PROCESS | 23440 | |11;stanford-crypto-ccm;121;130;126;130;126;125;134;121;126;129 04:26:08 INFO - PROCESS | 23440 | |12;stanford-crypto-pbkdf2;141;151;151;149;156;140;150;148;152;141 04:26:08 INFO - PROCESS | 23440 | |13;stanford-crypto-sha256-iterative;74;72;72;73;72;78;73;71;71;72 04:26:08 INFO - PROCESS | 23440 | __end_tp_report 04:26:08 INFO - PROCESS | 23440 | __start_cc_report 04:26:08 INFO - PROCESS | 23440 | _x_x_mozilla_cycle_collect,806 04:26:08 INFO - PROCESS | 23440 | __end_cc_report 04:26:08 INFO - PROCESS | 23440 | __startTimestamp1453292768967__endTimestamp 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | ------- Summary: start ------- 04:26:08 INFO - PROCESS | 23440 | Number of tests: 14 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#0] ai-astar Cycles:10 Average:117.70 Median:117.00 stddev:5.46 (4.7%) stddev-sans-first:5.79 04:26:08 INFO - PROCESS | 23440 | Values: 118.0 111.0 117.0 116.0 119.0 132.0 116.0 115.0 117.0 116.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:159.50 stddev:16.02 (10.0%) stddev-sans-first:16.64 04:26:08 INFO - PROCESS | 23440 | Values: 164.0 131.0 165.0 177.0 148.0 155.0 155.0 139.0 176.0 137.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.37 (1.4%) stddev-sans-first:2.35 04:26:08 INFO - PROCESS | 23440 | Values: 162.0 164.0 163.0 168.0 162.0 165.0 169.0 163.0 164.0 164.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#3] audio-fft Cycles:10 Average:89.70 Median:74.00 stddev:32.84 (44.4%) stddev-sans-first:34.40 04:26:08 INFO - PROCESS | 23440 | Values: 75.0 74.0 74.0 153.0 74.0 73.0 74.0 75.0 151.0 74.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:98.00 stddev:17.74 (18.1%) stddev-sans-first:18.38 04:26:08 INFO - PROCESS | 23440 | Values: 98.0 97.0 139.0 97.0 98.0 99.0 131.0 98.0 98.0 133.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 04:26:08 INFO - PROCESS | 23440 | Values: 110.0 111.0 110.0 110.0 110.0 111.0 111.0 110.0 109.0 109.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:26:08 INFO - PROCESS | 23440 | Values: 148.0 148.0 148.0 147.0 149.0 150.0 149.0 149.0 148.0 147.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.05 (1.1%) stddev-sans-first:1.12 04:26:08 INFO - PROCESS | 23440 | Values: 97.0 99.0 98.0 98.0 96.0 97.0 96.0 97.0 96.0 96.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#8] json-parse-financial Cycles:10 Average:74.60 Median:75.00 stddev:1.65 (2.2%) stddev-sans-first:1.73 04:26:08 INFO - PROCESS | 23440 | Values: 74.0 75.0 76.0 74.0 75.0 74.0 73.0 75.0 78.0 72.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 04:26:08 INFO - PROCESS | 23440 | Values: 68.0 69.0 69.0 69.0 69.0 68.0 69.0 70.0 69.0 69.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 04:26:08 INFO - PROCESS | 23440 | Values: 82.0 84.0 84.0 84.0 83.0 84.0 86.0 83.0 85.0 84.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.50 stddev:4.08 (3.2%) stddev-sans-first:3.75 04:26:08 INFO - PROCESS | 23440 | Values: 121.0 130.0 126.0 130.0 126.0 125.0 134.0 121.0 126.0 129.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.50 stddev:5.43 (3.6%) stddev-sans-first:5.15 04:26:08 INFO - PROCESS | 23440 | Values: 141.0 151.0 151.0 149.0 156.0 140.0 150.0 148.0 152.0 141.0 04:26:08 INFO - PROCESS | 23440 | 04:26:08 INFO - PROCESS | 23440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:2.04 (2.8%) stddev-sans-first:2.12 04:26:08 INFO - PROCESS | 23440 | Values: 74.0 72.0 72.0 73.0 72.0 78.0 73.0 71.0 71.0 72.0 04:26:08 INFO - PROCESS | 23440 | -------- Summary: end -------- 04:26:08 INFO - PROCESS | 23440 | 04:26:09 INFO - TEST-INFO | 23440: exit 0 04:26:09 INFO - TEST-OK | kraken | took 61928ms 04:26:09 INFO - TEST-START | v8_7 04:26:09 INFO - operating with platform_type : linux_ 04:26:09 INFO - Initialising browser for v8_7 test... 04:26:09 INFO - TEST-INFO | started process 23725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp725vVv/profile http://localhost:46812/getInfo.html) 04:26:13 INFO - PROCESS | 23725 | 04:26:13 INFO - PROCESS | 23725 | (process:23794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:14 INFO - PROCESS | 23725 | __metrics Screen width/height:1600/1200 04:26:14 INFO - PROCESS | 23725 | colorDepth:24 04:26:14 INFO - PROCESS | 23725 | Browser inner width/height: 1024/697 04:26:14 INFO - PROCESS | 23725 | __metrics 04:26:14 INFO - PROCESS | 23725 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:26:15 INFO - TEST-INFO | 23725: exit 0 04:26:15 INFO - Browser initialized. 04:26:15 INFO - Running cycle 1/1 for v8_7 test... 04:26:15 INFO - TEST-INFO | started process 23843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp725vVv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:16 INFO - PROCESS | 23843 | -- checkerboarding starts below -- 04:26:16 INFO - PROCESS | 23843 | RENDERTRACE 0.057414 rect red 0 0 10 10 // viewport 04:26:16 INFO - PROCESS | 23843 | RENDERTRACE 23.5074 rect brown 0 0 10 10 // page 04:26:16 INFO - PROCESS | 23843 | RENDERTRACE 23.5361 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:26:16 INFO - PROCESS | 23843 | Checkerboarded for 1 frames (24.7343 ms), 100 peak, 2 severity. 04:26:17 INFO - PROCESS | 23843 | 04:26:17 INFO - PROCESS | 23843 | (process:23900): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:27 INFO - PROCESS | 23843 | RSS: Main: 150212608 04:26:27 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:46812/tests/v8_7/run.html (next: http://localhost:46812/tests/v8_7/run.html) 04:26:50 INFO - PROCESS | 23843 | RSS: Main: 145530880 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | __start_tp_report 04:26:50 INFO - PROCESS | 23843 | _x_x_mozilla_page_load 04:26:50 INFO - PROCESS | 23843 | _x_x_mozilla_page_load_details 04:26:50 INFO - PROCESS | 23843 | |i|pagename|runs| 04:26:50 INFO - PROCESS | 23843 | |0;Richards;167.53224995811695 04:26:50 INFO - PROCESS | 23843 | |1;DeltaBlue;189.32222642938282 04:26:50 INFO - PROCESS | 23843 | |2;Encrypt;278.08676307007784 04:26:50 INFO - PROCESS | 23843 | |3;Decrypt;5208.333333333333 04:26:50 INFO - PROCESS | 23843 | |4;RayTrace;1077.5862068965516 04:26:50 INFO - PROCESS | 23843 | |5;Earley;722.0216606498195 04:26:50 INFO - PROCESS | 23843 | |6;Boyer;12575 04:26:50 INFO - PROCESS | 23843 | |7;RegExp;43170.21276595745 04:26:50 INFO - PROCESS | 23843 | |8;Splay;598.8023952095808 04:26:50 INFO - PROCESS | 23843 | |9;NavierStokes;4840.579710144928 04:26:50 INFO - PROCESS | 23843 | __end_tp_report 04:26:50 INFO - PROCESS | 23843 | __startTimestamp1453292810477__endTimestamp 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | ------- Summary: start ------- 04:26:50 INFO - PROCESS | 23843 | Number of tests: 10 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 167.5 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#1] DeltaBlue Cycles:1 Average:189.32 Median:189.32 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 189.3 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 278.1 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 5208.3 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 1077.6 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 722.0 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 12575.0 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#7] RegExp Cycles:1 Average:43170.21 Median:43170.21 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 43170.2 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#8] Splay Cycles:1 Average:598.80 Median:598.80 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 598.8 04:26:50 INFO - PROCESS | 23843 | 04:26:50 INFO - PROCESS | 23843 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:26:50 INFO - PROCESS | 23843 | Values: 4840.6 04:26:50 INFO - PROCESS | 23843 | -------- Summary: end -------- 04:26:50 INFO - PROCESS | 23843 | 04:26:51 INFO - TEST-INFO | 23843: exit 0 04:26:51 INFO - TEST-OK | v8_7 | took 41473ms 04:26:51 INFO - SUITE-END | took 1217s 04:26:51 INFO - Completed test suite (00:20:17) 04:26:51 INFO - Working with test: dromaeo_css 04:26:51 INFO - Generating results file: dromaeo_css 04:26:51 INFO - Working with test: kraken 04:26:51 INFO - Generating results file: kraken 04:26:51 INFO - javascript benchmark 04:26:51 INFO - Working with test: v8_7 04:26:51 INFO - Generating results file: v8_7 04:26:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:26:51 INFO - process_Request line: dromaeo_css 6027.65 graph.html#tests=[[72,132,43]] 04:26:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:51 INFO - process_Request line: kraken 1565.60 graph.html#tests=[[232,132,43]] 04:26:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:51 INFO - process_Request line: v8_7 20192.43 graph.html#tests=[[230,132,43]] 04:26:51 INFO - RETURN: dromaeo_css: 6027.65 04:26:51 INFO - RETURN: kraken: 1565.60 04:26:51 INFO - RETURN: v8_7: 20192.43 04:26:51 INFO - javascript benchmark 04:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.1239334822835, 2620.960685589716, 2649.8675066246697, 2650.9469810603778, 2662.1214999050308, 4436.29019356903, 4441.977790111049, 4459.777011149442, 4478.91042179157, 4519.638428925687, 4523.2762757958735, 4568.0, 4571.108633816407, 4636.3740894979255, 4638.956234847166, 3964.8612298569556, 4132.483439570054, 4216.683748718843, 4227.196832601811, 4299.656027517807, 4216.177845320149, 4237.216115018731, 4259.0, 4271.487421509423, 4311.913761724763, 4081.673466122703, 4144.48193975753, 4162.708610397273, 4203.684723645708, 4216.85241016566, 4183.247015537202, 4183.477065366829, 4212.220739163234, 4225.408442818008, 4227.0, 4101.815418306153, 4178.540360560336, 4179.393987871742, 4186.183694179636, 4203.0, 4345.739255644671, 4427.114577084596, 4461.598456138963, 4474.53017433168, 4502.707324023961, 4852.660313778037, 4875.634327425421, 4876.853694389174, 4883.243097319921, 4885.413750349945, 4777.856664300042, 4848.709077455329, 4913.656044076916, 4924.113659541281, 4944.629152813553, 4476.216662084123, 4532.478764942008, 4536.138133754576, 4573.794179261941, 4580.450345958439, 4951.529604687549, 4979.775910084055, 4986.426560945538, 4991.500849915052, 5007.69953802773, 4669.789859456333, 4739.810407583658, 4745.501722319107, 4788.257820037899, 4838.95161048385, 4863.10032643962, 4876.926846097312, 4883.34074899891, 4887.315775791392, 4929.112759703288, 4825.734584597811, 4826.493218212107, 4835.274708793709, 4836.395450568679, 4848.0788650156355, 4657.953420465819, 4751.691140075953, 4761.047790441926, 4815.422149342031, 4831.106245344622, 4078.57174996627, 4079.3065178919655, 4091.365838295069, 4100.220958017967, 4101.26177288085, 3555.9111022224133, 3561.821908904544, 3571.9641304021543, 3594.748367614242, 3610.241849211695, 4158.688098392633, 4216.51510076339, 4237.343211802114, 4291.356296555542, 4317.460317460317, 4730.266808644666, 4731.455882573479, 4745.715257084586, 4753.643476739258, 4770.833020844254, 4140.648044916215, 4143.81352839123, 4150.605692459211, 4175.185838761412, 4187.937180942288, 4210.852620158341, 4263.509696384894, 4291.227579035741, 4308.353746937984, 4339.392485052095, 4612.215923293048, 4619.099275641218, 4624.514425985358, 4630.4443466784205, 4677.041206552649, 4755.6195504358875, 4853.344798452164, 4854.077725232195, 4856.295837103529, 4906.092372911023, 4564.543545645409, 4567.977160114311, 4591.150637132141, 4624.02895391958, 4639.884002899955, 4786.880327991688, 4800.879978000578, 4803.255495398219, 4814.229723244264, 4846.297286893451, 4764.737939413366, 4849.781759820887, 4897.118518666674, 4900.656954013328, 4917.704937703749, 4654.837080702159, 4655.976720116378, 4680.578747912704, 4685.250359942393, 4725.834595789131, 4644.419447569054, 4648.070385922897, 4651.186042442491, 4651.209294419889, 4694.483606803181, 4473.530279320625, 4524.751138687404, 4541.886452838706, 4566.725996440225, 4580.862574122782, 4734.360861283821, 4753.524647535219, 4754.952450475451, 4767.523247675204, 4783.928241076317, 4652.767361631973, 4656.092062047868, 4659.347691323285, 4665.906681866276, 4697.318888761179], "unit": "score", "name": "dojo.html", "value": 4450.776374144834}, {"lowerIsBetter": false, "replicates": [484.76973437617113, 488.84845697833674, 495.66542583755955, 524.8687828042989, 552.7480257217401, 24907.0, 25604.35989100271, 32538.0, 32613.51079733806, 32692.509612355832, 36081.0, 36522.26955460896, 36642.083947901316, 36708.81645591775, 36738.81630591843, 7641.35048520875, 7843.33331666809, 7847.529148251095, 7850.960745196266, 7860.803479913019, 7471.066116735408, 7606.657700403495, 7608.961955190216, 7610.1628820829665, 7626.504277221963, 7767.184445633212, 7838.176991415876, 7843.372530197599, 7853.725119620814, 7859.331956783681, 7749.728759493419, 7775.844483110306, 7776.688932442696, 7806.921930780704, 7823.569703666296, 7683.961580192119, 7904.960475197645, 7939.5633240171765, 7953.602319883983, 7973.32226760726, 36383.272334553425, 37074.81462592697, 37113.25773484542, 37126.0, 37223.25553488915, 2856.3144845237202, 2857.6713677927096, 2950.822950622948, 3332.4334863073095, 3337.749668774827, 27373.589396159074, 27466.0, 27633.171004869888, 27860.860695696392, 27872.0, 3450.6721861423125, 3493.0917961329983, 3496.4230901901155, 3501.6148223695373, 3550.7692000019915, 197707.0, 199168.0, 199439.0, 200010.0, 200081.99959000258, 46900.0, 47579.28631070536, 53152.20271695928, 53335.19997200045, 53878.0, 49954.50045499499, 49988.500114999115, 50066.749666252166, 50211.49788502068, 50353.74823125861, 12333.444994975247, 12426.689332766573, 12469.812952805714, 12483.93758031204, 12489.12576119681, 9454.669086581936, 9568.61725530971, 9582.712518624452, 9608.711738647851, 9612.711618651452, 17788.199531021135, 18241.908790455964, 18760.437186884414, 18766.0, 18870.52823679419, 6796.218434880052, 6990.26602206761, 7042.330978557029, 7123.394511466479, 7145.392641625416, 856.39624065034, 869.6516423992371, 919.7240827751648, 956.7082039977735, 963.9878127965608, 26064.869675651502, 26088.60867086995, 26248.60627090595, 26260.212193634223, 26264.0, 859.6647307550061, 940.1022023967095, 940.5673390240567, 955.0306438964457, 960.7406000379858, 13761.931190344185, 13956.581302560939, 13960.58118256454, 14232.146071235551, 14506.347214375379, 241765.0, 242109.36835947476, 243211.0, 244589.0, 245271.0, 44947.55052449499, 44952.0, 45072.54927450683, 45075.549244507136, 45113.77443112763, 1170.1750266062406, 1199.0527483288279, 1200.6278053803348, 1210.842590463234, 1216.1365430544236, 26210.213693589223, 26455.074072407373, 26596.867015664797, 26744.59883101794, 26801.597976030764, 39767.005824853455, 40144.79927600343, 40297.395539067526, 40437.19125617413, 40496.595034050464, 232240.0, 232608.0, 233265.0, 234214.0, 234686.0, 27890.86054569714, 28542.714572854005, 28935.421291574472, 28994.565081524215, 29019.85490072536, 33463.0, 33795.83102084474, 34455.138621534665, 34519.0, 36367.818160909024, 30702.539461907643, 31456.213594660316, 31623.367532648757, 31888.202794930312, 32161.678383216804, 31140.532892006184, 31200.207655292106, 31521.054368368987, 31550.36899262048, 31553.684463155074, 31065.53401698931, 31199.0, 31395.37209255848, 31446.0, 31458.685413145577, 26819.32951676224, 29798.25504362408, 30446.543301850932, 30595.54106688357, 30730.539041914835, 21295.8935205323, 22029.779702202773, 22684.432889177904, 22942.311730648107, 22988.540229195656], "unit": "score", "name": "ext.html", "value": 16111.318113339848}, {"lowerIsBetter": false, "replicates": [320.5032200089861, 324.7077630132879, 327.8442739698643, 339.6501603348552, 344.6467370944783, 14615.707685846277, 14713.926430367834, 15196.31616577254, 15315.540533783991, 15366.539003829903, 9942.10521053105, 10202.74493137672, 12163.452644631012, 15067.62330941727, 15077.396904123849, 4482.843100491484, 4685.9062818743605, 4691.0617876424685, 4704.106219818241, 4859.538343857328, 4799.928001079987, 4894.877628059309, 4901.632377571678, 4929.580985616227, 5055.949440505603, 4688.789004494806, 4886.096072226632, 4899.167141585921, 5618.438156184389, 5653.773849046033, 4811.158047341736, 4892.951070489303, 4908.460069392364, 4937.5556199942, 5259.15853463444, 5045.571126454256, 5069.239614057884, 5072.061668591323, 5073.695578265316, 5081.542661160476, 10893.128549716082, 11000.669979900616, 11386.462827518344, 11397.259178153394, 11398.202125851194, 1765.1086201468177, 1781.5278951077976, 1787.49950013995, 1873.4566975577065, 1936.2932529626585, 8400.747977560623, 9287.931887832918, 11306.717332066764, 11561.132915031407, 11624.94187529057, 1642.244567498952, 1652.0665823809509, 1656.6769479951415, 1698.8962648168292, 1701.0559139677473, 46427.76786116081, 47187.0, 47306.76346618245, 48052.51947480515, 48345.27482087771, 9226.0, 9458.763530911783, 9501.762455938657, 9510.09654082861, 9523.857142142873, 11915.0, 11922.523099076114, 11982.16124871268, 12023.076307790887, 12055.939720301343, 6575.80272591823, 6648.268690444047, 6664.400203981665, 6698.363655452724, 6708.396244338033, 6204.937950620526, 6226.097215903668, 6234.75060997555, 6256.249250090018, 6303.684815759194, 3972.741771784825, 4013.237484877864, 4013.3578627420056, 4026.4362989180954, 4033.979830100831, 1574.8188958269716, 1576.8896177267711, 1682.142107525171, 1692.1031853117868, 1707.581642497596, 814.8288859339486, 832.7085520068049, 904.9049849765811, 929.4609126706493, 945.7021038372891, 14785.334659940328, 14807.481738139113, 14876.330565124596, 14945.103293802407, 15177.848221517865, 787.2363807107212, 830.8670612702059, 846.386369881843, 865.1737590600961, 876.7019213467452, 7782.221777822286, 8583.871241931376, 8607.139286071468, 8770.25452836516, 8897.332700047522, 441049.0, 446732.0, 448766.0, 454017.0, 454177.0, 60136.69931650314, 61532.38467615356, 62717.37282627207, 62939.370606294266, 63693.68153159205, 985.0199051943363, 1013.4983183324301, 1024.2215915903967, 1085.0776839686202, 1085.3433672627946, 13657.180569165881, 13676.863231367559, 13703.931480342535, 13928.651783705489, 13981.021328506908, 30415.54376684307, 30460.84769576138, 30649.233769155948, 31056.68943310538, 31708.365832682757, 38383.61616383912, 38597.6140238594, 39590.60409395869, 39640.80179599083, 41053.79473102615, 3349.547811045575, 3524.629913859008, 6024.849378765566, 6468.2561505427475, 6612.900806488003, 6741.797746067626, 9357.812843743222, 9477.715668529956, 9555.952220238854, 9876.308658393844, 8130.918690813016, 8244.422890397855, 8732.34507411934, 8745.256653184551, 8809.867851982097, 8446.746597602081, 8829.472720214248, 8929.241014513838, 9615.375000624937, 9634.518274086127, 8865.512396818236, 8952.955235223782, 9036.412633178823, 9165.358424910191, 9261.72214833556, 6493.383128602775, 6867.450603951572, 6955.061066755923, 6979.232284448605, 7003.789886303419, 8474.703385381483, 8659.956700216459, 8690.435121717068, 8928.241099506615, 8949.463032218087], "unit": "score", "name": "jquery.html", "value": 7240.919551621661}, {"lowerIsBetter": false, "replicates": [1330.0091431883247, 1335.9332033398327, 1401.5374926274324, 1636.026564194304, 1641.2614323554403, 6054.666993315366, 6190.102435146901, 6787.66061696915, 6986.196587392451, 6989.510734248598, 6532.608043517381, 6695.732170713178, 6763.66181690916, 6777.390034896858, 6807.72769089237, 2030.2995466564048, 2053.3634573282256, 2071.109422948132, 2072.626927153112, 2075.6575165097815, 2027.290448343083, 2043.2644248070683, 2052.3842847145797, 2060.9587808243828, 2063.998960504154, 2025.908834102469, 2026.402211347656, 2029.9594008119902, 2042.6935959606103, 2048.8770673759623, 2046.5292982613933, 2046.6827641715558, 2046.9385918422472, 2049.1291201239487, 2062.876227426359, 2037.2665840297482, 2048.805363490466, 2066.9896650516803, 2068.069368784053, 2070.244360808294, 7002.7899163025195, 7034.050403195605, 7050.118735158106, 7058.894116588255, 7085.964570177116, 3926.2147570486018, 4014.0767623446773, 4032.0, 4037.0714735610973, 4040.4141399496907, 2683.5437975544205, 2694.4745774573967, 2717.7418145276165, 2775.1951933939135, 2783.7772978161697, 833.0378412933072, 855.6534603485599, 861.6553378648528, 863.3999370437548, 899.5682072605186, 9506.904930950672, 9511.0, 9524.904750952472, 9537.0, 9589.136977671973, 3659.780413175218, 3669.376206044979, 3709.795961222159, 3711.536057992751, 3715.758475699071, 8010.19898010206, 8061.556614386148, 8062.395320350997, 8172.0, 8178.795530111675, 3967.107400834847, 3974.682025437958, 3978.741381810173, 3979.7612143271494, 4000.0, 3139.9058028259187, 3217.0670505553126, 3605.9278814423565, 3661.212839239523, 3674.9816250918575, 3250.398676244902, 3305.834708264625, 3325.717314028335, 3331.133905184621, 3338.3657105149946, 1034.6378767431338, 1039.3815679670583, 1042.4475028235047, 1044.070777008463, 1048.2871647279924, 967.6081187119228, 1095.0746619106842, 1106.5241945963312, 1115.6876074699098, 1123.2025262064026, 6391.712372943229, 6417.903731444032, 6457.160569125984, 6467.191601049869, 6469.805905822833, 1002.0931057393071, 1024.1704219582161, 1032.442481060234, 1035.6219979707353, 1048.5019615682643, 4850.902981940412, 4875.317455556225, 4905.460399356068, 4906.435759887588, 4912.361393018885, 7797.0, 8008.119106898236, 8232.794180145425, 8262.297704695047, 8275.255227029596, 7810.218978102144, 7822.413319001098, 7827.92172078272, 7858.292753652198, 7886.881696774438, 6295.527835412362, 6332.240131184288, 6373.235211774617, 6373.776917807854, 6407.647579383085, 6172.259328880563, 6275.403836635513, 6337.429631333202, 6346.555741098079, 6353.555251132561, 7170.856582868209, 7211.350978411968, 7251.419886408969, 7391.113066432063, 7392.22381649919, 7414.480986331121, 7464.6267686614365, 7514.62426878643, 7556.622168891424, 7590.506617069873, 5517.282753242052, 5670.347909990239, 5975.282966044103, 6124.356942520971, 6150.753969841336, 6360.713767880549, 6424.678766061772, 6443.484521238196, 6483.384078512534, 6496.740130394731, 6109.6334219945165, 6279.309275979547, 6309.211348581427, 6338.366163383625, 6387.105805187184, 6180.598261113013, 6249.812505624838, 6285.497160227263, 6342.90485642725, 6392.744290228339, 6300.054991751274, 6316.021016742412, 6341.682915854097, 6341.8731625368155, 6351.110844481684, 5839.532837372915, 5846.795362162304, 5871.530277577869, 5874.647521148745, 5882.647041177543, 5746.798862039808, 5794.449527294901, 5827.3881242470625, 5900.085486749561, 5908.734106965111], "unit": "score", "name": "mootools.html", "value": 3963.1038758190734}, {"lowerIsBetter": false, "replicates": [300.21493793729394, 302.9984850075751, 309.489342584735, 310.0357886971519, 310.5652087078092, 5568.582356323272, 5607.355154157273, 5636.689982050985, 5745.339285982108, 5782.24830771999, 5553.694546799924, 5625.46558076982, 5628.155776633507, 5641.323041235048, 5646.040173170561, 4044.1911617676437, 4122.299209134454, 4239.215745087154, 4250.596193361625, 4256.893577660568, 4166.062635906927, 4301.225779359714, 4311.935320970188, 4323.329883868006, 4334.241507736149, 4205.306124489471, 4217.283061879488, 4222.472190976128, 4231.957680423203, 4235.57644235577, 4221.0291632924445, 4221.366794980747, 4231.87304380869, 4232.25935461293, 4235.57644235577, 3676.1544844685873, 3680.300742858875, 3685.5577330720216, 3686.502322186497, 3696.1129328961124, 5271.42014378418, 5296.576273898079, 5352.277442545245, 5355.169948657965, 5371.57027437804, 4851.539103785135, 4880.731559764212, 4894.804207831682, 4897.2898929655, 4907.950920490785, 5820.156077368758, 5833.125031245305, 5834.6790926499025, 5837.532997360201, 5862.267216597926, 4021.879343619696, 4022.859199928018, 4027.436158937751, 4028.133951200506, 4032.1330913853662, 5876.882462350729, 6123.234595675541, 6129.448349648508, 6161.568690191689, 6171.56799024073, 4102.630763231324, 4113.197926404382, 4116.485439320085, 4131.29767939451, 4143.02638879863, 4198.916021679549, 4206.978965105216, 4207.305794543866, 4208.579142085767, 4211.515675697273, 4808.61531077513, 4826.58973987208, 4844.491328410537, 4844.95155048452, 4852.975735121302, 5698.059820129715, 5774.0, 5813.186153938452, 5818.970905145447, 5820.330661973842, 1454.5054681408371, 1462.7732701431296, 1465.5749832548654, 1469.426923499836, 1469.4856800120085, 971.6890595009529, 978.6134476881592, 985.3890587835588, 985.7141428985657, 987.2644879564626, 5119.360079990001, 5121.103806833864, 5123.205903085028, 5144.408393034774, 5152.098382782998, 5978.5814992950945, 6053.697315134314, 6124.448799607968, 6128.846778830476, 6146.262448506208, 5134.229865520202, 5135.35808023997, 5152.355955505562, 5164.14791559396, 5177.559907407837, 3267.591551056118, 3287.7862938908893, 3302.3890580242733, 3306.3883181611477, 3316.336732653479, 5694.088945768657, 5776.537876969833, 5810.738516766755, 5812.738426770806, 5813.331466881278, 6320.747170113144, 6326.177596912464, 6334.208223972004, 6338.176037115146, 6340.461060809791, 5820.35976042635, 5858.091995740667, 5869.853253668607, 5883.470487656132, 5888.764449422061, 5935.228420305332, 6070.969645151746, 6107.786227482017, 6109.938900611115, 6146.262448506208, 5942.049272116441, 5964.045752679551, 5978.252718410199, 5986.311574169026, 6011.729472173675, 5791.391903850035, 5808.912866306924, 5817.680027598522, 5825.446582574648, 5831.825045248649, 4084.7140700151895, 4121.855735049259, 4122.690798190088, 4125.463689720437, 4129.15352352773, 5873.970630146993, 6106.847328816815, 6127.908081378694, 6136.478399336106, 6142.14010038586, 5903.940960590339, 5930.733117009659, 5962.582619216613, 5969.761209551743, 5980.192673988956, 5888.587798854039, 5905.055191169392, 5917.378675239038, 5921.585489015728, 5928.081147422156, 5712.857178570569, 5786.479216870502, 5801.071828507418, 5801.883962320646, 5850.7074646266665, 5850.7074646266665, 5920.111983202554, 5948.702564871825, 5958.851028724316, 5965.791197308247, 5632.324121105494, 5784.161296612052, 5787.681677507778, 5789.507891829242, 5792.333881603501], "unit": "score", "name": "prototype.html", "value": 4381.749992479015}, {"lowerIsBetter": false, "replicates": [648.5840245087049, 653.875763604915, 661.1108059659757, 716.1978583985937, 763.7899577616158, 10691.78616427671, 10869.076128529065, 10901.890981090197, 10921.726956826084, 10934.343939363634, 10115.291929564934, 10178.541965611546, 10189.643362482315, 10203.642872499464, 10226.897731022687, 577.9335376431723, 590.8493334199773, 719.6437763307144, 736.6905899522213, 738.656524716007, 732.8644200822838, 733.413269384493, 735.7645553422907, 737.870872597296, 738.9852202955938, 757.6211894052974, 760.4524742185645, 762.1730422491603, 762.8169239382564, 762.9427792915526, 758.7382353088203, 758.9316961473467, 759.6277823866266, 760.0803028335721, 760.6158889760691, 567.1096378685465, 567.5402923631872, 567.7303280941561, 568.7497501099502, 569.7236840132532, 10566.471676416148, 10605.84091238632, 10608.522616482276, 10623.681289561326, 10640.840387394195, 11196.496157672924, 11623.418829058513, 11656.358900260482, 11664.125190610654, 11778.823317650242, 9439.764005899839, 9478.810423791485, 9569.617215311378, 9582.856257156078, 9589.808203835884, 3215.26049008727, 3236.0, 3254.7721659483846, 3265.2816380396275, 3339.782914110575, 42083.0, 42109.36835947433, 42694.0, 42719.57280427187, 42913.14173716508, 8630.309575233967, 8687.0, 8774.780630484289, 8814.118588141135, 8820.250278726251, 14634.926825365805, 14675.486357977634, 14811.703765924836, 14854.2572871356, 14906.105633662015, 6066.272047354346, 6163.9383606164265, 6387.776427825004, 6464.191976003, 6646.6676666166495, 3549.5563054618174, 3568.1971556399603, 3629.2378600494194, 3633.0372451300427, 3634.2186429917697, 2556.9744302556737, 2574.6395504629368, 2585.974140258611, 2587.236765154284, 2599.4671092426006, 465.36012982149543, 467.4997752404962, 469.577380357674, 474.3690891114809, 477.315052899084, 442.16651611712155, 481.5882420530466, 524.1587252459823, 532.9733513324318, 535.3014316317166, 7001.054857594159, 7126.251743566851, 7763.4953728007495, 7797.259260370256, 8017.959910200411, 445.3320019970045, 470.54122230824674, 529.9602529810203, 530.3079481276893, 553.6346011632303, 3405.9148521287166, 3587.5336206293014, 3606.13452771333, 3745.194783121642, 3782.583915769263, 45143.0, 45359.54640453553, 45364.319535206996, 45550.31674524885, 45563.31655025177, 40570.59429405727, 41173.588264116974, 41381.37927931084, 41482.0, 42016.0, 36923.26153476915, 37971.81014094912, 37994.810025950246, 38703.22593548169, 38748.225035499694, 7136.964315178391, 7276.05411296528, 7300.233475484997, 7355.77932662021, 7363.889541656987, 28494.43011139807, 28637.28406789847, 29060.56409153822, 29422.264443389085, 29555.261118472212, 33787.662123379436, 33914.98255052352, 35840.82079589585, 37835.81082094572, 37971.240575188895, 8931.776705582412, 9054.185123338932, 9216.03231660666, 9277.304202184729, 9414.811703766023, 9482.478463684563, 9608.663696770858, 9655.034496550288, 9874.506274686093, 9969.950150249202, 9365.812683746422, 9369.203617692572, 9422.670206542738, 9470.810583788423, 9865.260105491972, 9021.413608115452, 9222.308326875376, 9239.122283383067, 9241.306901982512, 9604.615815367308, 8647.135286471303, 9267.258619310303, 9312.115349041831, 9567.138957493858, 9627.951860240653, 7721.53670779755, 7905.01187351581, 7976.9202307976175, 8208.747514910538, 8241.052278987992, 8256.669733210845, 8332.375071869512, 8355.331573474228, 8373.665053397795, 8483.95758021206], "unit": "score", "name": "yui.html", "value": 5318.671016010111}], "name": "dromaeo_css", "value": 6027.652628915149}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 111.0, 117.0, 116.0, 119.0, 132.0, 116.0, 115.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 117.7}, {"lowerIsBetter": true, "replicates": [164.0, 131.0, 165.0, 177.0, 148.0, 155.0, 155.0, 139.0, 176.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 154.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 168.0, 162.0, 165.0, 169.0, 163.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 153.0, 74.0, 73.0, 74.0, 75.0, 151.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 139.0, 97.0, 98.0, 99.0, 131.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 150.0, 149.0, 149.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 98.0, 98.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 74.0, 75.0, 74.0, 73.0, 75.0, 78.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 84.0, 83.0, 84.0, 86.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 126.0, 130.0, 126.0, 125.0, 134.0, 121.0, 126.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 151.0, 149.0, 156.0, 140.0, 150.0, 148.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 73.0, 72.0, 78.0, 73.0, 71.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1565.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [189.32222642938282], "unit": "score", "name": "DeltaBlue", "value": 349.235276}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12575.0], "unit": "score", "name": "Boyer", "value": 52.99904572564615}, {"lowerIsBetter": false, "replicates": [43170.21276595745], "unit": "score", "name": "RegExp", "value": 21.10216609167079}, {"lowerIsBetter": false, "replicates": [598.8023952095808], "unit": "score", "name": "Splay", "value": 136.08996999999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20192.426625360713}]} 04:26:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20192.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1565.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6027.65"}}} 04:26:51 INFO - Return code: 0 04:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:51 INFO - # TBPL SUCCESS # 04:26:51 INFO - Running post-action listener: _resource_record_post_action 04:26:51 INFO - Running post-run listener: _resource_record_post_run 04:26:52 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 541511680; Read time: 0; Write time: 580764 04:26:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233857024; Read time: 0; Write time: 373684 04:26:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 307654656; Read time: 0; Write time: 207080 04:26:52 INFO - Running post-run listener: _upload_blobber_files 04:26:52 INFO - Blob upload gear active. 04:26:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:52 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:52 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:54 INFO - (blobuploader) - INFO - Done attempting. 04:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:55 INFO - (blobuploader) - INFO - Done attempting. 04:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:55 INFO - Return code: 0 04:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84c6f54c6fadbc5d9221a9a1f097f6dc0f635df201317bf18c5b9d4d73b0341adad24e780298029cfb7b739fea0cb728a62c5595d9243f2095093cd0b7080eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33df973168b748c29d3817ac3a532184d0015166302dabc2406076d28852a19faa7f8957a42befe4ac8a35cd793c5f99bbbf8dfeb179f8f19fb04e0599897f9f"} 04:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:55 INFO - Contents: 04:26:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84c6f54c6fadbc5d9221a9a1f097f6dc0f635df201317bf18c5b9d4d73b0341adad24e780298029cfb7b739fea0cb728a62c5595d9243f2095093cd0b7080eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33df973168b748c29d3817ac3a532184d0015166302dabc2406076d28852a19faa7f8957a42befe4ac8a35cd793c5f99bbbf8dfeb179f8f19fb04e0599897f9f"} 04:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:55 INFO - Copying logs to upload dir... 04:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.326274 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-20 04:26:53.935804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 04:26:53.943874) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 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/Fx-Team-Non-PGO/sha512/84c6f54c6fadbc5d9221a9a1f097f6dc0f635df201317bf18c5b9d4d73b0341adad24e780298029cfb7b739fea0cb728a62c5595d9243f2095093cd0b7080eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33df973168b748c29d3817ac3a532184d0015166302dabc2406076d28852a19faa7f8957a42befe4ac8a35cd793c5f99bbbf8dfeb179f8f19fb04e0599897f9f"} build_url:https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/J-NrXcThTPeq2G5uJiWhJQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84c6f54c6fadbc5d9221a9a1f097f6dc0f635df201317bf18c5b9d4d73b0341adad24e780298029cfb7b739fea0cb728a62c5595d9243f2095093cd0b7080eb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33df973168b748c29d3817ac3a532184d0015166302dabc2406076d28852a19faa7f8957a42befe4ac8a35cd793c5f99bbbf8dfeb179f8f19fb04e0599897f9f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 04:26:53.974500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:26:53.974859) ========= 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=cbe409c6de289db6ac707de3000001d4-1453291507.378560-1511024665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:26:54.336961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:26:54.337334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:26:54.337672) ========= ========= Total master_lag: 1.11 =========