builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1475625032.25 results: success (0) buildid: 20161004122910 builduid: 2c4a2ad0ec2247bc96245f44d1aaec53 revision: 3fff88de2f2d5194bc940ad67ca2187498d00243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.248845) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.249299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.249574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.264327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.264699) ========= 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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 16:50:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-10-04 16:50:32 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.362065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.362516) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.411841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:32.412188) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3fff88de2f2d5194bc940ad67ca2187498d00243 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3fff88de2f2d5194bc940ad67ca2187498d00243 --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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 16:50:32,875 truncating revision to first 12 chars 2016-10-04 16:50:32,875 Setting DEBUG logging. 2016-10-04 16:50:32,876 attempt 1/10 2016-10-04 16:50:32,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3fff88de2f2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 16:50:33,178 unpacking tar archive at: autoland-3fff88de2f2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:33.098202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:33.098522) ========= script_repo_revision: 3fff88de2f2d5194bc940ad67ca2187498d00243 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:33.098986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:33.099250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:33.108168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-04 16:50:33.108502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:33 INFO - MultiFileLogger online at 20161004 16:50:33 in /builds/slave/test 16:50:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:50:33 INFO - {'append_to_log': False, 16:50:33 INFO - 'base_work_dir': '/builds/slave/test', 16:50:33 INFO - 'blob_upload_branch': 'Autoland', 16:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:50:33 INFO - 'branch': 'Autoland', 16:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:33 INFO - 'config_files': ('talos/linux_config.py',), 16:50:33 INFO - 'default_actions': ('clobber', 16:50:33 INFO - 'read-buildbot-config', 16:50:33 INFO - 'download-and-extract', 16:50:33 INFO - 'populate-webroot', 16:50:33 INFO - 'create-virtualenv', 16:50:33 INFO - 'install', 16:50:33 INFO - 'run-tests'), 16:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:33 INFO - 'download_minidump_stackwalk': True, 16:50:33 INFO - 'download_symbols': 'ondemand', 16:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:33 INFO - 'installer_path': 'installer.exe', 16:50:33 INFO - 'log_level': 'info', 16:50:33 INFO - 'log_name': 'talos', 16:50:33 INFO - 'log_to_console': True, 16:50:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:33 INFO - 'opt_config_files': (), 16:50:33 INFO - 'pip_index': False, 16:50:33 INFO - 'sps_profile': False, 16:50:33 INFO - 'sps_profile_interval': 0, 16:50:33 INFO - 'suite': 'dromaeojs-e10s', 16:50:33 INFO - 'system_bits': '32', 16:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:33 INFO - 'title': 'talos-linux64-ix-027', 16:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:33 INFO - 'use_talos_json': True, 16:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:33 INFO - 'work_dir': 'build'} 16:50:33 INFO - [mozharness: 2016-10-04 23:50:33.672277Z] Running clobber step. 16:50:33 INFO - Running pre-action listener: _resource_record_pre_action 16:50:33 INFO - Running main action method: clobber 16:50:33 INFO - rmtree: /builds/slave/test/build 16:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:50:34 INFO - Running post-action listener: _resource_record_post_action 16:50:34 INFO - [mozharness: 2016-10-04 23:50:34.138727Z] Finished clobber step (success) 16:50:34 INFO - [mozharness: 2016-10-04 23:50:34.138831Z] Running read-buildbot-config step. 16:50:34 INFO - Running pre-action listener: _resource_record_pre_action 16:50:34 INFO - Running main action method: read_buildbot_config 16:50:34 INFO - Using buildbot properties: 16:50:34 INFO - { 16:50:34 INFO - "project": "", 16:50:34 INFO - "product": "firefox", 16:50:34 INFO - "script_repo_revision": "production", 16:50:34 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 16:50:34 INFO - "repository": "", 16:50:34 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 16:50:34 INFO - "buildid": "20161004122910", 16:50:34 INFO - "pgo_build": "True", 16:50:34 INFO - "basedir": "/builds/slave/test", 16:50:34 INFO - "buildnumber": 278, 16:50:34 INFO - "slavename": "talos-linux64-ix-027", 16:50:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:50:34 INFO - "platform": "ubuntu64_hw", 16:50:34 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 16:50:34 INFO - "branch": "autoland", 16:50:34 INFO - "repo_path": "integration/autoland", 16:50:34 INFO - "revision": "3fff88de2f2d5194bc940ad67ca2187498d00243", 16:50:34 INFO - "stage_platform": "linux64-pgo", 16:50:34 INFO - "builduid": "2c4a2ad0ec2247bc96245f44d1aaec53", 16:50:34 INFO - "slavebuilddir": "test" 16:50:34 INFO - } 16:50:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:50:34 INFO - Running post-action listener: _resource_record_post_action 16:50:34 INFO - [mozharness: 2016-10-04 23:50:34.141264Z] Finished read-buildbot-config step (success) 16:50:34 INFO - [mozharness: 2016-10-04 23:50:34.141352Z] Running download-and-extract step. 16:50:34 INFO - Running pre-action listener: _resource_record_pre_action 16:50:34 INFO - Running main action method: download_and_extract 16:50:34 INFO - mkdir: /builds/slave/test/build/tests 16:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:34 INFO - trying https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:34 INFO - Downloading https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:50:34 INFO - Downloaded 1201 bytes. 16:50:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:34 INFO - Using the following test package requirements: 16:50:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:50:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'jsshell-linux-x86_64.zip'], 16:50:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:50:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:34 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:50:35 INFO - Http code: 200 16:50:35 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 16:50:35 INFO - x-amz-cf-id: h5S_78ro3ugy9AfzfO-cpzIU4GHAPy5uSsgm73YdGSQlQCE_NLcloA== 16:50:35 INFO - x-amz-version-id: UO0DQJAgYk3Pc3litkY.3x3CPCA7um.N 16:50:35 INFO - Expected file size: 21992460 16:50:35 INFO - Obtained file size: 21992460 16:50:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:50:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:50:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:39 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:50:40 INFO - Http code: 200 16:50:40 INFO - via: 1.1 bfdd5909914586f5bc4851846228c27f.cloudfront.net (CloudFront) 16:50:40 INFO - x-amz-cf-id: m55G6Hbl2cTjuiQChmWjq9eavTU-zMHbSBxkzq4N2rSFXXM92SCwBQ== 16:50:40 INFO - x-amz-version-id: UO0DQJAgYk3Pc3litkY.3x3CPCA7um.N 16:50:40 INFO - Expected file size: 21992460 16:50:40 INFO - Obtained file size: 21992460 16:50:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:44 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:50:45 INFO - Http code: 200 16:50:45 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 16:50:45 INFO - x-amz-cf-id: ZoPudYeYjpckYx9uwRESQL_e0o_yJ_aifHy9dbXHkFPW-JAOrNLyBA== 16:50:45 INFO - x-amz-version-id: zr856J6Lqmy33guSFJYe5OUV7Wo3DHRX 16:50:45 INFO - Expected file size: 14409006 16:50:45 INFO - Obtained file size: 14409006 16:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:45 INFO - trying https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:45 INFO - Downloading https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:47 INFO - Downloaded 59702429 bytes. 16:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:47 INFO - mkdir: /builds/slave/test/properties 16:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:50:47 INFO - Contents: 16:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:47 INFO - Running post-action listener: _resource_record_post_action 16:50:47 INFO - Running post-action listener: set_extra_try_arguments 16:50:47 INFO - [mozharness: 2016-10-04 23:50:47.722110Z] Finished download-and-extract step (success) 16:50:47 INFO - [mozharness: 2016-10-04 23:50:47.722337Z] Running populate-webroot step. 16:50:47 INFO - Running pre-action listener: _resource_record_pre_action 16:50:47 INFO - Running main action method: populate_webroot 16:50:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:47 INFO - '--tppagecycles', 16:50:47 INFO - '7'], 16:50:47 INFO - 'tests': ['tsvgm']}}, 16:50:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:50:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:50:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['damp', 'tps']}, 16:50:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'tests': ['damp', 'tps']}, 16:50:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['dromaeo_dom']}, 16:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['basic_compositor_video']}, 16:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:50:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['a11yr', 16:50:47 INFO - 'ts_paint', 16:50:47 INFO - 'tpaint', 16:50:47 INFO - 'sessionrestore', 16:50:47 INFO - 'sessionrestore_no_auto_restore', 16:50:47 INFO - 'tabpaint']}, 16:50:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['tsvgx', 16:50:47 INFO - 'tsvgr_opacity', 16:50:47 INFO - 'tart', 16:50:47 INFO - 'tscrollx', 16:50:47 INFO - 'cart']}, 16:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:50:47 INFO - 'tsvgr_opacity', 16:50:47 INFO - 'tart', 16:50:47 INFO - 'tscrollx', 16:50:47 INFO - 'cart']}, 16:50:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'talos_options': ['--disable-e10s'], 16:50:47 INFO - 'tests': ['tp5o']}, 16:50:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'tests': ['tp5o']}, 16:50:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'talos_options': ['--disable-e10s', 16:50:47 INFO - '--xperf_path', 16:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:47 INFO - 'tests': ['tp5n']}, 16:50:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:47 INFO - 'talos_options': ['--xperf_path', 16:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:47 INFO - 'tests': ['tp5n']}}, 16:50:47 INFO - 'talos.zip': {'path': '', 16:50:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:47 INFO - Running post-action listener: _resource_record_post_action 16:50:47 INFO - [mozharness: 2016-10-04 23:50:47.742644Z] Finished populate-webroot step (success) 16:50:47 INFO - [mozharness: 2016-10-04 23:50:47.742732Z] Running create-virtualenv step. 16:50:47 INFO - Running pre-action listener: _resource_record_pre_action 16:50:47 INFO - Running main action method: create_virtualenv 16:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:50:47 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 16:50:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:47 INFO - Using real prefix '/usr' 16:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:50:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:50 INFO - Installing pip.................done. 16:50:50 INFO - Return code: 0 16:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:50:50 INFO - Reading from file tmpfile_stdout 16:50:50 INFO - Output received: 16:50:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:50:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:50 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:50 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 16:50:50 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 16:50:50 INFO - Using env: {'DISPLAY': ':0', 16:50:50 INFO - 'HOME': '/home/cltbld', 16:50:50 INFO - 'LANG': 'en_US.UTF-8', 16:50:50 INFO - 'LANGUAGE': 'en_US:en', 16:50:50 INFO - 'LOGNAME': 'cltbld', 16:50:50 INFO - 'MAIL': '/var/mail/cltbld', 16:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:50 INFO - 'MOZ_NO_REMOTE': '1', 16:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:50 INFO - 'NO_EM_RESTART': '1', 16:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:50 INFO - 'PWD': '/builds/slave/test', 16:50:50 INFO - 'SHELL': '/bin/bash', 16:50:50 INFO - 'SHLVL': '1', 16:50:50 INFO - 'TERM': 'linux', 16:50:50 INFO - 'TMOUT': '86400', 16:50:50 INFO - 'USER': 'cltbld', 16:50:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:50 INFO - '_': '/tools/buildbot/bin/python'} 16:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:50 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 16:50:50 INFO - Cleaning up... 16:50:50 INFO - Return code: 0 16:50:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:50 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:50 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>=3.1.1'] in /builds/slave/test/build 16:50:50 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>=3.1.1 16:50:50 INFO - Using env: {'DISPLAY': ':0', 16:50:50 INFO - 'HOME': '/home/cltbld', 16:50:50 INFO - 'LANG': 'en_US.UTF-8', 16:50:50 INFO - 'LANGUAGE': 'en_US:en', 16:50:50 INFO - 'LOGNAME': 'cltbld', 16:50:50 INFO - 'MAIL': '/var/mail/cltbld', 16:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:50 INFO - 'MOZ_NO_REMOTE': '1', 16:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:50 INFO - 'NO_EM_RESTART': '1', 16:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:50 INFO - 'PWD': '/builds/slave/test', 16:50:50 INFO - 'SHELL': '/bin/bash', 16:50:50 INFO - 'SHLVL': '1', 16:50:50 INFO - 'TERM': 'linux', 16:50:50 INFO - 'TMOUT': '86400', 16:50:50 INFO - 'USER': 'cltbld', 16:50:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:50 INFO - '_': '/tools/buildbot/bin/python'} 16:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:50 INFO - Downloading/unpacking psutil>=3.1.1 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:52 INFO - Installing collected packages: psutil 16:50:52 INFO - Running setup.py install for psutil 16:50:53 INFO - building 'psutil._psutil_linux' extension 16:50:53 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 16:50:53 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 16:50:53 INFO - building 'psutil._psutil_posix' extension 16:50:53 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 16:50:53 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 16:50:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:53 INFO - Successfully installed psutil 16:50:53 INFO - Cleaning up... 16:50:53 INFO - Return code: 0 16:50:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:53 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.3'] in /builds/slave/test/build 16:50:53 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.3 16:50:53 INFO - Using env: {'DISPLAY': ':0', 16:50:53 INFO - 'HOME': '/home/cltbld', 16:50:53 INFO - 'LANG': 'en_US.UTF-8', 16:50:53 INFO - 'LANGUAGE': 'en_US:en', 16:50:53 INFO - 'LOGNAME': 'cltbld', 16:50:53 INFO - 'MAIL': '/var/mail/cltbld', 16:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:53 INFO - 'MOZ_NO_REMOTE': '1', 16:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:53 INFO - 'NO_EM_RESTART': '1', 16:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:53 INFO - 'PWD': '/builds/slave/test', 16:50:53 INFO - 'SHELL': '/bin/bash', 16:50:53 INFO - 'SHLVL': '1', 16:50:53 INFO - 'TERM': 'linux', 16:50:53 INFO - 'TMOUT': '86400', 16:50:53 INFO - 'USER': 'cltbld', 16:50:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:53 INFO - '_': '/tools/buildbot/bin/python'} 16:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:50:53 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 16:50:53 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 16:50:53 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 16:50:53 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 16:50:53 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 16:50:53 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 16:50:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:50:55 INFO - Installing collected packages: mozsystemmonitor 16:50:55 INFO - Running setup.py install for mozsystemmonitor 16:50:55 INFO - Successfully installed mozsystemmonitor 16:50:55 INFO - Cleaning up... 16:50:55 INFO - Return code: 0 16:50:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:55 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:55 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==2.5.1'] in /builds/slave/test/build 16:50:55 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==2.5.1 16:50:55 INFO - Using env: {'DISPLAY': ':0', 16:50:55 INFO - 'HOME': '/home/cltbld', 16:50:55 INFO - 'LANG': 'en_US.UTF-8', 16:50:55 INFO - 'LANGUAGE': 'en_US:en', 16:50:55 INFO - 'LOGNAME': 'cltbld', 16:50:55 INFO - 'MAIL': '/var/mail/cltbld', 16:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:55 INFO - 'MOZ_NO_REMOTE': '1', 16:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:55 INFO - 'NO_EM_RESTART': '1', 16:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:55 INFO - 'PWD': '/builds/slave/test', 16:50:55 INFO - 'SHELL': '/bin/bash', 16:50:55 INFO - 'SHLVL': '1', 16:50:55 INFO - 'TERM': 'linux', 16:50:55 INFO - 'TMOUT': '86400', 16:50:55 INFO - 'USER': 'cltbld', 16:50:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:55 INFO - '_': '/tools/buildbot/bin/python'} 16:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:58 INFO - warning: no files found matching '*.txt' 16:50:58 INFO - no previously-included directories found matching 'build' 16:50:58 INFO - no previously-included directories found matching 'dist' 16:50:58 INFO - no previously-included directories found matching '.git*' 16:50:58 INFO - Installing collected packages: jsonschema, functools32 16:50:58 INFO - Running setup.py install for functools32 16:50:58 INFO - warning: no files found matching '*.txt' 16:50:58 INFO - no previously-included directories found matching 'build' 16:50:58 INFO - no previously-included directories found matching 'dist' 16:50:58 INFO - no previously-included directories found matching '.git*' 16:50:58 INFO - Successfully installed jsonschema functools32 16:50:58 INFO - Cleaning up... 16:50:58 INFO - Return code: 0 16:50:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:50:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:58 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:50:58 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 functools32==3.2.3-2 16:50:58 INFO - Using env: {'DISPLAY': ':0', 16:50:58 INFO - 'HOME': '/home/cltbld', 16:50:58 INFO - 'LANG': 'en_US.UTF-8', 16:50:58 INFO - 'LANGUAGE': 'en_US:en', 16:50:58 INFO - 'LOGNAME': 'cltbld', 16:50:58 INFO - 'MAIL': '/var/mail/cltbld', 16:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:58 INFO - 'MOZ_NO_REMOTE': '1', 16:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:58 INFO - 'NO_EM_RESTART': '1', 16:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:58 INFO - 'PWD': '/builds/slave/test', 16:50:58 INFO - 'SHELL': '/bin/bash', 16:50:58 INFO - 'SHLVL': '1', 16:50:58 INFO - 'TERM': 'linux', 16:50:58 INFO - 'TMOUT': '86400', 16:50:58 INFO - 'USER': 'cltbld', 16:50:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:58 INFO - '_': '/tools/buildbot/bin/python'} 16:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:50:58 INFO - Cleaning up... 16:50:58 INFO - Return code: 0 16:50:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:50:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:50:58 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 16:50:58 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 16:50:58 INFO - Using env: {'DISPLAY': ':0', 16:50:58 INFO - 'HOME': '/home/cltbld', 16:50:58 INFO - 'LANG': 'en_US.UTF-8', 16:50:58 INFO - 'LANGUAGE': 'en_US:en', 16:50:58 INFO - 'LOGNAME': 'cltbld', 16:50:58 INFO - 'MAIL': '/var/mail/cltbld', 16:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:58 INFO - 'MOZ_NO_REMOTE': '1', 16:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:58 INFO - 'NO_EM_RESTART': '1', 16:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:58 INFO - 'PWD': '/builds/slave/test', 16:50:58 INFO - 'SHELL': '/bin/bash', 16:50:58 INFO - 'SHLVL': '1', 16:50:58 INFO - 'TERM': 'linux', 16:50:58 INFO - 'TMOUT': '86400', 16:50:58 INFO - 'USER': 'cltbld', 16:50:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:58 INFO - '_': '/tools/buildbot/bin/python'} 16:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:58 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 16:50:58 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 16:50:58 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 16:50:58 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 16:50:58 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 16:50:58 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 16:51:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:01 INFO - Downloading docopt-0.6.1.tar.gz 16:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:01 INFO - Running setup.py install for blobuploader 16:51:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:01 INFO - Running setup.py install for requests 16:51:01 INFO - Running setup.py install for docopt 16:51:02 INFO - Successfully installed blobuploader requests docopt 16:51:02 INFO - Cleaning up... 16:51:02 INFO - Return code: 0 16:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:02 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:51:02 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 16:51:02 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 16:51:02 INFO - Using env: {'DISPLAY': ':0', 16:51:02 INFO - 'HOME': '/home/cltbld', 16:51:02 INFO - 'LANG': 'en_US.UTF-8', 16:51:02 INFO - 'LANGUAGE': 'en_US:en', 16:51:02 INFO - 'LOGNAME': 'cltbld', 16:51:02 INFO - 'MAIL': '/var/mail/cltbld', 16:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:02 INFO - 'MOZ_NO_REMOTE': '1', 16:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:02 INFO - 'NO_EM_RESTART': '1', 16:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:02 INFO - 'PWD': '/builds/slave/test', 16:51:02 INFO - 'SHELL': '/bin/bash', 16:51:02 INFO - 'SHLVL': '1', 16:51:02 INFO - 'TERM': 'linux', 16:51:02 INFO - 'TMOUT': '86400', 16:51:02 INFO - 'USER': 'cltbld', 16:51:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:02 INFO - '_': '/tools/buildbot/bin/python'} 16:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:02 INFO - Running setup.py (path:/tmp/pip-z4WuKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:02 INFO - Running setup.py (path:/tmp/pip-oKwSwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:02 INFO - Running setup.py (path:/tmp/pip-DfwLTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:02 INFO - Running setup.py (path:/tmp/pip-qgrvIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:02 INFO - Running setup.py (path:/tmp/pip-CZjotH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:02 INFO - Running setup.py (path:/tmp/pip-oxbB1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:02 INFO - Running setup.py (path:/tmp/pip-Hvj04i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 INFO - Running setup.py (path:/tmp/pip-SbSO0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:02 INFO - Running setup.py (path:/tmp/pip-YvNWlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:03 INFO - Running setup.py (path:/tmp/pip-3HWFDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:03 INFO - Running setup.py (path:/tmp/pip-6GVIbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:03 INFO - Running setup.py (path:/tmp/pip-S4Hu16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:03 INFO - Running setup.py (path:/tmp/pip-c6sk7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:03 INFO - Running setup.py (path:/tmp/pip-cDbAC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:03 INFO - Running setup.py (path:/tmp/pip-norHlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:03 INFO - Running setup.py (path:/tmp/pip-aOplCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:03 INFO - Running setup.py (path:/tmp/pip-9Fm_4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:03 INFO - Running setup.py install for manifestparser 16:51:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozcrash 16:51:03 INFO - Running setup.py install for mozdebug 16:51:03 INFO - Running setup.py install for mozdevice 16:51:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozfile 16:51:04 INFO - Running setup.py install for mozhttpd 16:51:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozinfo 16:51:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozInstall 16:51:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozleak 16:51:04 INFO - Running setup.py install for mozlog 16:51:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for moznetwork 16:51:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozprocess 16:51:04 INFO - Running setup.py install for mozprofile 16:51:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozrunner 16:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:05 INFO - Running setup.py install for mozscreenshot 16:51:05 INFO - Running setup.py install for moztest 16:51:05 INFO - Running setup.py install for mozversion 16:51:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:05 INFO - Cleaning up... 16:51:05 INFO - Return code: 0 16:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:51:05 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 16:51:05 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 16:51:05 INFO - Using env: {'DISPLAY': ':0', 16:51:05 INFO - 'HOME': '/home/cltbld', 16:51:05 INFO - 'LANG': 'en_US.UTF-8', 16:51:05 INFO - 'LANGUAGE': 'en_US:en', 16:51:05 INFO - 'LOGNAME': 'cltbld', 16:51:05 INFO - 'MAIL': '/var/mail/cltbld', 16:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:05 INFO - 'MOZ_NO_REMOTE': '1', 16:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:05 INFO - 'NO_EM_RESTART': '1', 16:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:05 INFO - 'PWD': '/builds/slave/test', 16:51:05 INFO - 'SHELL': '/bin/bash', 16:51:05 INFO - 'SHLVL': '1', 16:51:05 INFO - 'TERM': 'linux', 16:51:05 INFO - 'TMOUT': '86400', 16:51:05 INFO - 'USER': 'cltbld', 16:51:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:05 INFO - '_': '/tools/buildbot/bin/python'} 16:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:05 INFO - Running setup.py (path:/tmp/pip-YMLGUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:05 INFO - Running setup.py (path:/tmp/pip-kJcU8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:05 INFO - Running setup.py (path:/tmp/pip-HWVrTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:05 INFO - Running setup.py (path:/tmp/pip-eupdNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:05 INFO - Running setup.py (path:/tmp/pip-0_IT_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:05 INFO - Running setup.py (path:/tmp/pip-YTyQPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:06 INFO - Running setup.py (path:/tmp/pip-nTQyxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:06 INFO - Running setup.py (path:/tmp/pip-HHQ7Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:06 INFO - Running setup.py (path:/tmp/pip-x7qXtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:06 INFO - Running setup.py (path:/tmp/pip-9qpLEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:06 INFO - Running setup.py (path:/tmp/pip-79E7o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:06 INFO - Running setup.py (path:/tmp/pip-NxhBab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:06 INFO - Running setup.py (path:/tmp/pip-naw_8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:06 INFO - Running setup.py (path:/tmp/pip-FToEv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:06 INFO - Running setup.py (path:/tmp/pip-mJbFhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:06 INFO - Running setup.py (path:/tmp/pip-nAks0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:06 INFO - Running setup.py (path:/tmp/pip-_TnQfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:06 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)) 16:51:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:51:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:08 INFO - Downloading blessings-1.6.tar.gz 16:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:08 INFO - Installing collected packages: blessings 16:51:08 INFO - Running setup.py install for blessings 16:51:08 INFO - Successfully installed blessings 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:09 INFO - Reading from file tmpfile_stdout 16:51:09 INFO - Current package versions: 16:51:09 INFO - argparse == 1.2.1 16:51:09 INFO - blessings == 1.6 16:51:09 INFO - blobuploader == 1.2.4 16:51:09 INFO - docopt == 0.6.1 16:51:09 INFO - functools32 == 3.2.3-2 16:51:09 INFO - jsonschema == 2.5.1 16:51:09 INFO - manifestparser == 1.1 16:51:09 INFO - mozInstall == 1.12 16:51:09 INFO - mozcrash == 0.17 16:51:09 INFO - mozdebug == 0.1 16:51:09 INFO - mozdevice == 0.48 16:51:09 INFO - mozfile == 1.2 16:51:09 INFO - mozhttpd == 0.7 16:51:09 INFO - mozinfo == 0.9 16:51:09 INFO - mozleak == 0.1 16:51:09 INFO - mozlog == 3.4 16:51:09 INFO - moznetwork == 0.27 16:51:09 INFO - mozprocess == 0.23 16:51:09 INFO - mozprofile == 0.28 16:51:09 INFO - mozrunner == 6.12 16:51:09 INFO - mozscreenshot == 0.1 16:51:09 INFO - mozsystemmonitor == 0.3 16:51:09 INFO - moztest == 0.7 16:51:09 INFO - mozversion == 1.4 16:51:09 INFO - psutil == 3.1.1 16:51:09 INFO - requests == 1.2.3 16:51:09 INFO - wsgiref == 0.1.2 16:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:09 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:51:09 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 16:51:09 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 16:51:09 INFO - Using env: {'DISPLAY': ':0', 16:51:09 INFO - 'HOME': '/home/cltbld', 16:51:09 INFO - 'LANG': 'en_US.UTF-8', 16:51:09 INFO - 'LANGUAGE': 'en_US:en', 16:51:09 INFO - 'LOGNAME': 'cltbld', 16:51:09 INFO - 'MAIL': '/var/mail/cltbld', 16:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:09 INFO - 'MOZ_NO_REMOTE': '1', 16:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:09 INFO - 'NO_EM_RESTART': '1', 16:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:09 INFO - 'PWD': '/builds/slave/test', 16:51:09 INFO - 'SHELL': '/bin/bash', 16:51:09 INFO - 'SHLVL': '1', 16:51:09 INFO - 'TERM': 'linux', 16:51:09 INFO - 'TMOUT': '86400', 16:51:09 INFO - 'USER': 'cltbld', 16:51:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:09 INFO - '_': '/tools/buildbot/bin/python'} 16:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 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)) 16:51:09 INFO - Cleaning up... 16:51:09 INFO - Return code: 0 16:51:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:09 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 0x7f56ea80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a99790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, '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': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', '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 16:51:09 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 16:51:09 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 16:51:09 INFO - Using env: {'DISPLAY': ':0', 16:51:09 INFO - 'HOME': '/home/cltbld', 16:51:09 INFO - 'LANG': 'en_US.UTF-8', 16:51:09 INFO - 'LANGUAGE': 'en_US:en', 16:51:09 INFO - 'LOGNAME': 'cltbld', 16:51:09 INFO - 'MAIL': '/var/mail/cltbld', 16:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:09 INFO - 'MOZ_NO_REMOTE': '1', 16:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:09 INFO - 'NO_EM_RESTART': '1', 16:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:09 INFO - 'PWD': '/builds/slave/test', 16:51:09 INFO - 'SHELL': '/bin/bash', 16:51:09 INFO - 'SHLVL': '1', 16:51:09 INFO - 'TERM': 'linux', 16:51:09 INFO - 'TMOUT': '86400', 16:51:09 INFO - 'USER': 'cltbld', 16:51:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:09 INFO - '_': '/tools/buildbot/bin/python'} 16:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:09 INFO - Cleaning up... 16:51:09 INFO - Return code: 0 16:51:09 INFO - Running post-action listener: _resource_record_post_action 16:51:09 INFO - Running post-action listener: _start_resource_monitoring 16:51:09 INFO - Starting resource monitoring. 16:51:09 INFO - [mozharness: 2016-10-04 23:51:09.718727Z] Finished create-virtualenv step (success) 16:51:09 INFO - [mozharness: 2016-10-04 23:51:09.719245Z] Running install step. 16:51:09 INFO - Running pre-action listener: _resource_record_pre_action 16:51:09 INFO - Running main action method: install 16:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:09 INFO - Reading from file tmpfile_stdout 16:51:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:10 INFO - Reading from file tmpfile_stdout 16:51:10 INFO - Output received: 16:51:10 INFO - Usage: mozinstall [options] installer 16:51:10 INFO - Options: 16:51:10 INFO - -h, --help show this help message and exit 16:51:10 INFO - -d DEST, --destination=DEST 16:51:10 INFO - Directory to install application into. [default: 16:51:10 INFO - "/builds/slave/test"] 16:51:10 INFO - --app=APP Application being installed. [default: firefox] 16:51:10 INFO - mkdir: /builds/slave/test/build/application 16:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:51:27 INFO - Reading from file tmpfile_stdout 16:51:27 INFO - Output received: 16:51:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:51:27 INFO - Running post-action listener: _resource_record_post_action 16:51:27 INFO - [mozharness: 2016-10-04 23:51:27.024978Z] Finished install step (success) 16:51:27 INFO - [mozharness: 2016-10-04 23:51:27.025222Z] Running run-tests step. 16:51:27 INFO - Running pre-action listener: _resource_record_pre_action 16:51:27 INFO - Running main action method: run_tests 16:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:27 INFO - Python 2.7.3 16:51:27 INFO - Return code: 0 16:51:27 INFO - grabbing minidump binary from tooltool 16:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:27 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a96930>, '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 0x1a97830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a97cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:27 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 16:51:27 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 16:51:27 INFO - Calling ['/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'] with output_timeout 600 16:51:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:27 INFO - Return code: 0 16:51:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:51:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:51:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 16:51:27 INFO - Using env: {'DISPLAY': ':0', 16:51:27 INFO - 'HOME': '/home/cltbld', 16:51:27 INFO - 'LANG': 'en_US.UTF-8', 16:51:27 INFO - 'LANGUAGE': 'en_US:en', 16:51:27 INFO - 'LOGNAME': 'cltbld', 16:51:27 INFO - 'MAIL': '/var/mail/cltbld', 16:51:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:27 INFO - 'MOZ_NO_REMOTE': '1', 16:51:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:27 INFO - 'NO_EM_RESTART': '1', 16:51:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:27 INFO - 'PWD': '/builds/slave/test', 16:51:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:27 INFO - 'SHELL': '/bin/bash', 16:51:27 INFO - 'SHLVL': '1', 16:51:27 INFO - 'TERM': 'linux', 16:51:27 INFO - 'TMOUT': '86400', 16:51:27 INFO - 'USER': 'cltbld', 16:51:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825', 16:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:27 INFO - '_': '/tools/buildbot/bin/python'} 16:51:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:51:27 INFO - mozversion application_buildid: 20161004122910 16:51:27 INFO - mozversion application_changeset: 3fff88de2f2d5194bc940ad67ca2187498d00243 16:51:27 INFO - mozversion application_display_name: Nightly 16:51:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:27 INFO - mozversion application_name: Firefox 16:51:27 INFO - mozversion application_remotingname: firefox 16:51:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:51:27 INFO - mozversion application_vendor: Mozilla 16:51:27 INFO - mozversion application_version: 52.0a1 16:51:27 INFO - mozversion platform_buildid: 20161004122910 16:51:27 INFO - mozversion platform_changeset: 3fff88de2f2d5194bc940ad67ca2187498d00243 16:51:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:51:27 INFO - mozversion platform_version: 52.0a1 16:51:27 INFO - using testdate: 1475625087 16:51:27 INFO - actual date: 1475625087 16:51:27 INFO - starting webserver on 'localhost:37194' 16:51:27 INFO - SUITE-START | Running 2 tests 16:51:27 INFO - TEST-START | dromaeo_css 16:51:27 INFO - operating with platform_type : linux_ 16:51:27 INFO - Initialising browser for dromaeo_css test... 16:51:27 INFO - TEST-INFO | started process 1881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1fq2Gz/profile http://localhost:37194/getInfo.html) 16:51:31 INFO - PROCESS | 1881 | __metrics Screen width/height:1600/1200 16:51:31 INFO - PROCESS | 1881 | colorDepth:24 16:51:31 INFO - PROCESS | 1881 | Browser inner width/height: 1024/697 16:51:31 INFO - PROCESS | 1881 | __metrics 16:51:32 ERROR - PROCESS | 1881 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 16:51:33 INFO - TEST-INFO | 1881: exit 0 16:51:33 INFO - Browser initialized. 16:51:33 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:33 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1fq2Gz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:45 INFO - PROCESS | 2001 | RSS: Main: 185421824 16:51:45 INFO - PROCESS | 2001 | 16:52:34 INFO - PROCESS | 2001 | 1475625154919 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] 16:54:45 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37194/tests/dromaeo/cssquery-ext.html) 16:54:47 INFO - PROCESS | 2001 | RSS: Main: 200007680 16:54:47 INFO - PROCESS | 2001 | 16:57:49 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-ext.html (next: http://localhost:37194/tests/dromaeo/cssquery-jquery.html) 16:57:49 INFO - PROCESS | 2001 | RSS: Main: 199811072 16:57:49 INFO - PROCESS | 2001 | 17:00:51 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37194/tests/dromaeo/cssquery-mootools.html) 17:00:52 INFO - PROCESS | 2001 | RSS: Main: 199245824 17:00:52 INFO - PROCESS | 2001 | 17:03:54 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37194/tests/dromaeo/cssquery-prototype.html) 17:03:54 INFO - PROCESS | 2001 | RSS: Main: 195612672 17:03:54 INFO - PROCESS | 2001 | 17:06:57 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37194/tests/dromaeo/cssquery-yui.html) 17:06:57 INFO - PROCESS | 2001 | RSS: Main: 199254016 17:06:57 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:37194/tests/dromaeo/cssquery-yui.html (next: http://localhost:37194/tests/dromaeo/cssquery-dojo.html) 17:10:00 INFO - PROCESS | 2001 | RSS: Main: 199630848 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | __start_tp_report 17:10:00 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 17:10:00 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 17:10:00 INFO - PROCESS | 2001 | |i|pagename|runs| 17:10:00 INFO - PROCESS | 2001 | |0;dojo.html;3071.769617278704;3076.215565030917;3089.4902341113716;3113.972389111593;3115.2834847984977;5132.230165475181;5302.337207849019;5321.068812957731;5378.677279363236;5401.945980540203;5184.248283998818;5272.051030814452;5363.302770639821;5434.91847622285;5449.128139497681;4790.784414701347;4816.614670826326;4901.485344038878;4925.778339974692;4990.775415106329;4842.29786680931;4921.384826896638;5029.622778291643;5034.043531728978;5053.823116190934;4790.065937142259;4833.540813622701;4864.8297309594345;4877.780499877496;4878.414590249157;4869.464358920516;4909.607231421478;4927.433345165316;4961.156603377434;4976.154053810861;4857.429927588946;4876.7808047988;4876.853694389174;4896.216605343164;4958;5118.360204974379;5206.843794686166;5308.256844041837;5345.1447768356875;5383.138697808332;5562.749676264578;5635.6055076144685;5641.943580564182;5665.830025099253;5738.110592858114;5670.6030577859565;5672.773089076432;5712.542996560265;5730.7421166047625;5731.111677689964;5211.817586384458;5308.867278318073;5310.92033619496;5322.1484562470205;5352.732363381815;5731.083026715705;5751.827445176651;5783.595148339576;5800.53595712342;5892.94107058924;5569.554435645138;5580.330360356783;5586.13414920688;5595.8601034973635;5645.266115404971;5594.0769772987815;5605.887882242332;5702.572307076903;5714.5999780015;5718.599698021182;5505.6696598204235;5517.337919449692;5551.444855514416;5571.777128914798;5608.074667679869;5725.8568535786935;5733.426657334317;5739.71301434935;5744.281964754406;5780.16187652788;4389.056352884145;4399.274119770266;4401.823927042882;4426.9778651106535;4459.576340247671;3827.5024246847734;3848.4034974578985;3866.4586957825927;3897.7661340319673;3954.031262340745;5405.162199859028;5443.646162999393;5464.863378415572;5494.945050549443;5546.362168350692;5688.146777983253;5710.942890571041;5739.569532285095;5755.9424405756245;5758.3090029196765;5245.501677340647;5270.49930256625;5396.946030539723;5472.2338872557875;5482.753276102585;4912.6561140719805;4934;4961.4046314441775;4966.379202599675;4969.950300497021;5945.137954996588;5946.524278057745;5947.821565353046;5953;5958.314793798769;5545.390007099297;5619.353774316006;5742.799002034909;5748.741306641127;5754.3670196277535;5859.94140058594;5897.823065308047;5944.405559444021;5956.37458066914;6032.607880487754;5619;5654.830355089354;5663.32040155184;5673.74468148926;5678.517326027334;5423.132298832168;5707.514861236841;5761.827145185651;5763.221965034667;5782.913256301074;5315.893682126413;5543.113101903676;5591.552675786009;5606.775728970795;5688.288963879515;5579.6652200868075;5596.048671725898;5596.916046259391;5624.57815663835;5625.071863142699;5289.47105289468;5320.866978325573;5510.063289240758;5540.085885828793;5591.692456914909;5585.609007369608;5609.49514543693;5616.1014237721765;5650.124230744241;5716.456936591017;5458.5087342139395;5475.780968761205;5477.863053423696;5509;5518.117101263779 17:10:00 INFO - PROCESS | 2001 | |1;ext.html;545.7271364317841;550.2516577454661;560.4759549820915;562.3083607163187;567.452408425869;40465.59534404659;42576.36135457967;42648.93377665556;46558.53441465584;46607.30089048667;44156.779216103954;44668;44714.55285447145;44718.55281447185;44736;8759.474431534112;8994.235489983359;9021;9021.819563608757;9023.639054437816;8824.02935677075;8865.734027979172;8867.645294188225;8905.866412003825;8961.417507862001;8868.157525035143;8894.066123057082;8899.154580314893;8922.10778922109;8942.73171804847;8848.292136629087;8880.689175878846;8917.242034427081;8960.731178064669;8987.685431009882;7024.473164512631;7097.751578694721;7099.077119974422;7101.254368291358;7105.644717764091;41347;41881;41938;42041.36937945903;42098.36852447216;3192.6488086310487;3332.150301673082;3415.4023045966856;3779.7321607035833;3795.3168429682646;30441.847790760905;30890.536641950388;30973;31213.375732485223;31242.218944526343;4220.85227017053;4350.15172041452;4370.497392799837;4381.693281470299;4419.116176764628;353746;355081.22459387797;355649;357291;357346;58701.412985869596;59062.704686476296;59086.27309815204;59088.7045564778;59199.304090467966;61968.07047894285;62057;62225.37774622286;62263.37736622666;62408;14193.432262709583;14225.928870355581;14231.359588818528;14280.642983925485;14311.284435778169;12424.316662583464;12473.438695258736;12484.375781210903;12512.186707863959;12523.686907827378;14066.367013484418;15918.283677234553;18199;18340.174692138884;18348.055168138915;6852.738596263222;6960.547564408398;6960.965195174093;7211.12510747199;7407.222241664547;914.264017465933;985.9753506162403;1065.4588805698465;1090.2477290669412;1103.2442776697987;30560.235994100327;30660.080197594107;30684.232894177378;31177.688223117933;31516.842415787774;983.5623147699348;1057.471264367816;1063.4470075560819;1119.7536541960756;1162.5291756838494;15461.304241309168;15702.136382498844;15785.763213551805;15823;16306.75539866903;580420;583110;584751;588501;590553;55718;55763.44236557664;56493;56896;57041;1286.3632501911427;1301.5704817410233;1302.1861336664585;1320.6764342735898;1329.2954733991;28149.71850281553;28775.424491510472;28789.424211515234;29454.852725736233;30224.84887575548;47933;48348.5165148344;48429.5157048425;48530.757346213046;48660.5133948656;465939;466918;467500;467688;467819;27127.1861844145;27644.723552764215;27741.72258277472;27798.722012779614;28067.157985260474;45371.77314113409;45557.31664024976;45978.31032534582;46308.7684561575;46859.76570117127;38774.6122538771;38997.805010974764;39331.2133757329;40005.79997099996;41020.79489602533;38879.41680874732;39632.40551391674;39830.40254396128;40189;41964.580354197285;39393;39572.20855582815;39625.40561891632;39862.60137398705;40563;34063.31873362469;35826.64173358233;36294;36453.45319820152;36573.634263657026;27546.44907101887;27741.583876241468;27791.44417111687;27802;27843 17:10:00 INFO - PROCESS | 2001 | |2;jquery.html;391.9059425737823;397.1877510491046;397.84682897084616;398.8564116917909;430.76953829701114;18086.638267234648;18481.630367392645;18713.625727485458;18725.438236852882;19533.609327813436;18476.538086547844;18689;18812.30689237972;19139.138738756756;19202.807971920276;5604.663720176782;5621.634593751413;5821.417858214166;5880.4119588041285;5882.205902203212;5726.885462290752;5823.213866128082;5826.708664566776;5826.9708651456895;5840.474357307841;5550.306211723535;5720.942790572103;5760.855978600547;5781.479666829984;5789.884202315951;5762.596618236725;5783.595148339597;5849.151872978437;5855.47300742933;5870.73581688825;5092.465291144451;5184.818531351385;5205.6616319939085;5213.357792295453;5214.843554693365;22424.103035878547;22554.097836086537;22657;22858.19996300138;22895.885520572458;2265.5808675395106;2271.46620544172;2317.6291793313158;2554.693436787579;2736.58951157326;13780.862191378059;14045.532932108134;14261.28693565328;14664.706705865823;14705.338259778335;1782.4563508130016;1789.677857985562;1891.867569270138;1900.7624046994126;1978.1800743316185;76947.61526192389;77281;78238.60880695617;78427.60786196032;79771;9236.445813251092;9836.3606365586;9934.354266972623;10411.11505522039;10537;12457.377131143588;13366.33168341579;13455.443465741673;13516.324183790772;13518.324083795771;6123.173371594867;6147.139400483936;6173;6749.763758268437;7438.256174382518;6410.61536307823;6503.447206987365;6615.338466153443;6790.558613690095;6976.337247961435;4005.339119045383;4055.614716601918;4065.6340929316502;4098.590140985937;4119.114390406017;1961.4900125967351;1962.6957821537685;1973.2205778717325;2031.1063132221775;2064.721262629526;904.6245807989742;936.9109934556207;978.9265805064649;979.5004547680734;1004.6835246897203;17643.117844108;19094;19228.807711922982;19537.413877583695;20247.4938126548;948.7248697877676;961.3606951377395;968.5496244246459;984.3306551544875;1008.621766837436;10130.848037279447;10555.894441055645;10730.463476826128;10738.570457181782;10993.175511836644;415135;417455;436686;455210;456040;92567.53716231376;93934;95159;96844;99861;1010.1060561403211;1033.534909290807;1074.5486895503907;1089.4824958144818;1095.8356246562919;16884.227156148918;16886.24011919442;17385.391511297043;17571;17631;41591.37612935748;41765;42188.78905605452;42541.1934090544;42694.78652606717;59721;60278;60298.81914232443;61141.694291528256;63384.36615633785;7624.504407213513;7989;8341.791455213668;8558.315334773328;8567.443116197428;12784.169029013085;13529.526466573623;13545.1195672281;13615.387307571382;13827.723445531234;11557.653270401901;11596.710082248012;11715.121365897421;11831.940840295743;12120.939395302967;10738.785224295314;11115.88841115882;11127.221094523306;11193.776124477303;11195.793955810586;11542.82685759731;11659.941700291443;11720.941395292968;11945.820812687643;12093.939530302292;7847.0975837777105;7938.444308898322;7952.681892724227;8005.919940800517;8054.637541310538;11214.607488737855;11608.767824643292;11663.941680291544;11892.881071189177;11950.282983021047 17:10:00 INFO - PROCESS | 2001 | |3;mootools.html;1416.7237388709202;1478.807754991851;1558.2286768049817;1706.8378504042112;1717.4418314047937;7244.7826565202995;7429.665665045072;7847.568383738892;8432.409731318803;8501.319894408449;7599.696012159521;7733.651985660645;7748.96125519373;7973.561454120021;7978.92021079789;2220.822334213259;2227.2204728345114;2244.7194100737406;2249.302716157996;2260.1298500077505;2161.5676864627058;2174.1629472652985;2212.1814928476488;2222.288867562381;2225.688403623494;2151.8816465094415;2152.4080877758665;2156.892155392232;2163.448320678233;2166.2093335932427;2116.8412369072225;2133.519958009443;2142.9785702142935;2143.603433364825;2145.302776597612;2088.4778805298674;2161.7838216178416;2184.934451966428;2185.7595664476894;2191.7808219177955;8411.242988131098;8454.492730436132;8457.746267611981;8474.237318641352;8487.06642269356;4968.453470118284;5078.64449488536;5086.593072554187;5093.898122037538;5112.18205087188;3151.2909595341093;3236.3203727217315;3250.9349813003846;3252.9837350813095;3258.152880251128;1050.3277902142636;1091.5142761471147;1091.8307662312354;1111.1333160135027;1123.3260043973632;11299.604513841976;11318.151138664633;11322.943385283103;11341.149413793999;11342.659720208407;4109.178164367138;4405.713628614129;4412.227860124465;4418.497710778351;4438.667099967515;9658.323917325719;9688.41869487833;9709.320347575602;9725.367851089657;9777.31558790892;5088.135017047037;5104.132297509433;5109.335786347825;5111.846644600668;5141.331626888481;4016.979915100464;4520.525344838745;4605.125026245003;4686.109639168615;4727.787249573777;3766.4350347448103;3775.7734535927934;3874.283257597297;3880.3985382265796;3915.8433662653742;1237.7400745843474;1257.126297223421;1262.059765474727;1272.7518133963788;1287.8647741987145;805.7502174325978;810.2343285595056;815.6778072661266;922.5710044829052;925.2736601767715;5221.7128057956415;5364.892702145935;5437.8368648940595;5538.778448862081;5544.279243698374;416.85826818881725;419.82367405689683;422.2715815218723;422.7400148908399;434.4721163786015;3608.2061946371755;3700.40793473043;3731.9440208396354;3735.589085200626;3814.5803961564206;10188.745281368025;10304.175665946706;10313.896861031444;10315;10356.741081473023;10098.747531311776;10137.64518241858;10153.949230253802;10253.948730256301;10265.435401053013;7595.6961721531625;7766.922330776733;7770.611469426506;7779.222077792176;7788.454808163374;5217.269582258563;5367.973160134175;5417.918731218956;5420.186971954238;5513.5037846594;9286.257099432165;9398.812023759623;9465.952670236606;9555.140037396668;9575.09036641518;9026.277897768032;9457.527123643653;9485.33602647808;9486.85769713441;9489.051094890456;6956.234814170539;7105.680244388912;7259.382952449101;7491.400687945061;7686.46194766361;7933.761987140395;8201.466904651179;8260.710875119583;8303.6678532858;8313.168683131638;7296.270372962661;7381.151167615578;7401.888971665537;7487.138979017483;7574.924250757643;7016.614086225102;7061.152661680631;7064.646767661494;7194.496385252982;7295.343419092307;6738.090357801634;6763.188417389944;6780.660966951731;6784;6829.624370659462;4688.718676879398;4804.735739534359;4824.782884770124;4853.49038350968;4881.51184881509;4736.360591320127;4762.52374762521;4788;4877.097736918681;5038 17:10:00 INFO - PROCESS | 2001 | |4;prototype.html;297.72609199536424;301.7585931254996;310.8725422576744;321.21463022908983;328.06665037966974;5388.141091323487;5459.863503412406;5488.451154884509;5594.692291923948;5639.802606908754;5213.348331458567;5346.893062138755;5380.946190538093;5452.727363631812;5481.287432633762;4260.72305300156;4283.443152390185;4302.311630139178;4306.117245964578;4328.394024836525;4214.936775948363;4249.192653395845;4276.786160691969;4313.374560688699;4314.913701725964;4201.474815648044;4242.2182683273095;4251.59609837065;4252.723572967747;4252.766097864616;4239.491261048663;4253.702240843142;4260.42484264625;4291.270484017725;4308.328836121625;3654.798986055766;3804.600516945736;3813.733038687293;3819.2934307153264;3827.4067519534515;5175.896482070375;5243.692775178947;5251.343582052244;5267.499587539178;5314.5748340132695;4791.664583479158;4797.544233297831;4799.544043315879;4824.276358546211;4840.2255639097575;5511.807086751985;5605.607607467479;5645.645045189125;5647.265855438808;5675.3757086720425;4064.7764372959773;4081.7346622547107;4082.4284600156;4084.8774536763945;4103.589641035903;5922.881542369171;5937.524998000193;5938.7624495020145;5944.7324870380935;5953.851153721148;4083.2650122977557;4104.835806567764;4191.287481128215;4201.810918508674;4218.557051509609;4182.519010313792;4210.936835947463;4221.9023054005565;4228.175505776344;4237.237297286456;4796.952030479721;4819.927701084486;4827.662063655511;4827.95172048275;4836.153673107192;5430.565554755689;5713.314402271754;5761;5770.307563092372;5779.1506717850725;1371.7530844447895;1394.9302534873216;1396.7066915947562;1396.860313968595;1399.531157062375;877.8990416102102;896.8430524658289;908.9727308180766;919.7194855568982;922.4419226368085;4888.853334399973;4903;4907.2393778964315;4944.703317800943;4971.45314015458;5098.821541246039;5134.87162820925;5222.3733152022005;5241.292425522582;5273.551748101378;4696.2486002239475;4743.833965811249;4807.375041244616;4814.470408255089;4945.876353091202;2738.6439762830705;2762.392273699783;2762.8480433575946;2778.499610210504;2793.706660800627;5338.731039308278;5355.839324820262;5375.75809088592;5385.3268341457315;5391.73041347931;4983.651144419856;5152.587792976553;5154;5179.637425380187;5182.797311142749;5295.179247216687;5308;5325.680459172385;5362;5375;5179;5209.973950130225;5236.319278493771;5251.737413129405;5252.684838909678;4768.3085952537385;5023.598112150946;5069.3156423883775;5094.719790411563;5197.532222100029;5266.368035835724;5280.471952804843;5310.9734451327495;5332.70670113132;5353.457107873729;3751.3869036313554;3880.9417858731576;3925.3523168676847;3992.940105898356;4029.8992525187105;5771.509421699203;5776.566757493289;5791.333996590278;5796.362400135898;5832.833433313439;5573.331200255833;5681.2330335404195;5697.515711164431;5714.771409143587;5734.770609175586;5595.832125036255;5612.466815652507;5618.381977982501;5619.157126431068;5659;5605.178317047057;5612.635178713371;5636.351819540805;5639.605227634026;5675.177099320658;5538.224648549126;5590.957858229964;5676.318841739017;5680.602357834912;5746.511546518593;5569.972150139385;5570.690887641482;5615.831525054255;5631.915521267102;5633.492985631313 17:10:00 INFO - PROCESS | 2001 | |5;yui.html;710.7441321124396;725.9691238441412;764.7896828372195;793.3098204562032;801.4269797095076;15978.84021159788;16796.916015419938;16858.15709214539;16884.577885552866;16942.23759930803;15168.620784480367;15185.722141678754;15206.087634741923;15216.467423640175;15242.847571524282;746.5781833264216;752.7102065704715;754.4266357568233;757.9090509138883;757.9886301705465;779.8479296537178;781.4920301803816;783.0173132718459;783.1972228465811;784.3881772217651;818.6193420059672;822.3873214455209;823.1685997142869;828.9336853051772;830.4602008694367;817.8200795824908;817.8732296494053;818.5988865455884;826.9379796515256;827.7847759582492;609.5946195779801;610.5390430225151;610.6092101055284;610.9358517355703;611.0864257934372;14094.647633809236;14212.218327991955;14254;14258.928705356511;14268.143911365247;11990.520379184822;12590.68523286916;12601.747965040648;12664.81002784959;12888.871111288861;11921.463534140985;12014.65347920176;12063.21589096706;12068.456919438646;12317.199382040228;4301.677374196947;4341.804618792162;4403.031333106712;4403.2954727243805;4459.397981272519;84790;85940.99999999937;86318;88679;89953.99999999935;9653.9034609653;9722.513874306256;9884.802303954024;9937.354071985443;10179.134773544183;18270.903745775297;18288.17703203359;18302.54243643893;18368.816311836978;19255.8074419254;8247.95876020628;8478.872816907751;8621.137886211329;8623;8709.259712924346;4633.119707255611;4637.721736695809;4643.303504474288;4659.790309436084;4827;3606.5672119345845;3731.738778285494;3738.420544815558;3769.246150769857;3804.923901521954;633.3508154141949;640.8365866704054;641.1056576076347;642.9839254018686;648.6043513456788;688.7141836137947;690.102866273842;728.6757392960081;733.3033618062861;739.8705226585326;9085.409448385966;9185.95407022974;9505.952470237604;9536.952315238519;9584.233261339075;587.465406480101;626.7837596029362;634.9682515874188;684.4661164291861;725.0682872508801;4463.687541872037;4591.540845915381;4685.250359942393;4868.95690193629;4881.438634557071;112806;113032;114124;115707;119275;56694.43305566974;57290;58376.41623583795;59680.403195968356;62073.68963155246;86865.5656721725;89498.55250723705;90909;91465.54267228622;91726;8835.668891165315;9008.504532250789;9153.17621414076;9170.816583668422;9247;51409.33447540939;51732;51887.48112518978;52163.217551735994;53421.7328913353;46450.535494644624;74010;74550;74828.62585687036;78306.6084669573;11149.219554631098;11307.604233851776;11521.366324851879;11598.826017609574;11738.88261117412;12161.574344897886;12365.505379784709;12371.628851134481;12416.192947458387;12510.87489125097;11922.940385298365;11985.880141198477;12071.939640301742;12171.939140304241;12746.936265318614;11574.305541667527;11596;12108.21296615717;12278.938605306916;12542.12205145631;11462.4268786562;11740.941295293469;11744;11841.526338946345;12099.274043557414;9827.4103553787;9886.110250077527;10242.180625549789;10296;10617.362958222531;10472.738181545523;10720.785584288427;10771.353718776898;10778.245522813328;10794 17:10:00 INFO - PROCESS | 2001 | __end_tp_report 17:10:00 INFO - PROCESS | 2001 | __start_cc_report 17:10:00 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,301 17:10:00 INFO - PROCESS | 2001 | __end_cc_report 17:10:00 INFO - PROCESS | 2001 | __startTimestamp1475626200635__endTimestamp 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | ------- Summary: start ------- 17:10:00 INFO - PROCESS | 2001 | Number of tests: 6 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:5303.37 Median:5509.00 stddev:592.84 (10.8%) stddev-sans-first:568.23 17:10:00 INFO - PROCESS | 2001 | Values: 3071.8 3076.2 3089.5 3114.0 3115.3 5132.2 5302.3 5321.1 5378.7 5401.9 5184.2 5272.1 5363.3 5434.9 5449.1 4790.8 4816.6 4901.5 4925.8 4990.8 4842.3 4921.4 5029.6 5034.0 5053.8 4790.1 4833.5 4864.8 4877.8 4878.4 4869.5 4909.6 4927.4 4961.2 4976.2 4857.4 4876.8 4876.9 4896.2 4958.0 5118.4 5206.8 5308.3 5345.1 5383.1 5562.7 5635.6 5641.9 5665.8 5738.1 5670.6 5672.8 5712.5 5730.7 5731.1 5211.8 5308.9 5310.9 5322.1 5352.7 5731.1 5751.8 5783.6 5800.5 5892.9 5569.6 5580.3 5586.1 5595.9 5645.3 5594.1 5605.9 5702.6 5714.6 5718.6 5505.7 5517.3 5551.4 5571.8 5608.1 5725.9 5733.4 5739.7 5744.3 5780.2 4389.1 4399.3 4401.8 4427.0 4459.6 3827.5 3848.4 3866.5 3897.8 3954.0 5405.2 5443.6 5464.9 5494.9 5546.4 5688.1 5710.9 5739.6 5755.9 5758.3 5245.5 5270.5 5396.9 5472.2 5482.8 4912.7 4934.0 4961.4 4966.4 4970.0 5945.1 5946.5 5947.8 5953.0 5958.3 5545.4 5619.4 5742.8 5748.7 5754.4 5859.9 5897.8 5944.4 5956.4 6032.6 5619.0 5654.8 5663.3 5673.7 5678.5 5423.1 5707.5 5761.8 5763.2 5782.9 5315.9 5543.1 5591.6 5606.8 5688.3 5579.7 5596.0 5596.9 5624.6 5625.1 5289.5 5320.9 5510.1 5540.1 5591.7 5585.6 5609.5 5616.1 5650.1 5716.5 5458.5 5475.8 5477.9 5509.0 5518.1 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:62044.77 Median:42002.97 stddev:127438.89 (303.4%) stddev-sans-first:127712.74 17:10:00 INFO - PROCESS | 2001 | Values: 545.7 550.3 560.5 562.3 567.5 40465.6 42576.4 42648.9 46558.5 46607.3 44156.8 44668.0 44714.6 44718.6 44736.0 8759.5 8994.2 9021.0 9021.8 9023.6 8824.0 8865.7 8867.6 8905.9 8961.4 8868.2 8894.1 8899.2 8922.1 8942.7 8848.3 8880.7 8917.2 8960.7 8987.7 7024.5 7097.8 7099.1 7101.3 7105.6 41347.0 41881.0 41938.0 42041.4 42098.4 3192.6 3332.2 3415.4 3779.7 3795.3 30441.8 30890.5 30973.0 31213.4 31242.2 4220.9 4350.2 4370.5 4381.7 4419.1 353746.0 355081.2 355649.0 357291.0 357346.0 58701.4 59062.7 59086.3 59088.7 59199.3 61968.1 62057.0 62225.4 62263.4 62408.0 14193.4 14225.9 14231.4 14280.6 14311.3 12424.3 12473.4 12484.4 12512.2 12523.7 14066.4 15918.3 18199.0 18340.2 18348.1 6852.7 6960.5 6961.0 7211.1 7407.2 914.3 986.0 1065.5 1090.2 1103.2 30560.2 30660.1 30684.2 31177.7 31516.8 983.6 1057.5 1063.4 1119.8 1162.5 15461.3 15702.1 15785.8 15823.0 16306.8 580420.0 583110.0 584751.0 588501.0 590553.0 55718.0 55763.4 56493.0 56896.0 57041.0 1286.4 1301.6 1302.2 1320.7 1329.3 28149.7 28775.4 28789.4 29454.9 30224.8 47933.0 48348.5 48429.5 48530.8 48660.5 465939.0 466918.0 467500.0 467688.0 467819.0 27127.2 27644.7 27741.7 27798.7 28067.2 45371.8 45557.3 45978.3 46308.8 46859.8 38774.6 38997.8 39331.2 40005.8 41020.8 38879.4 39632.4 39830.4 40189.0 41964.6 39393.0 39572.2 39625.4 39862.6 40563.0 34063.3 35826.6 36294.0 36453.5 36573.6 27546.4 27741.6 27791.4 27802.0 27843.0 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:27473.93 Median:397.52 stddev:72407.72 (18215.0%) stddev-sans-first:72582.29 17:10:00 INFO - PROCESS | 2001 | Values: 391.9 397.2 397.8 398.9 430.8 18086.6 18481.6 18713.6 18725.4 19533.6 18476.5 18689.0 18812.3 19139.1 19202.8 5604.7 5621.6 5821.4 5880.4 5882.2 5726.9 5823.2 5826.7 5827.0 5840.5 5550.3 5720.9 5760.9 5781.5 5789.9 5762.6 5783.6 5849.2 5855.5 5870.7 5092.5 5184.8 5205.7 5213.4 5214.8 22424.1 22554.1 22657.0 22858.2 22895.9 2265.6 2271.5 2317.6 2554.7 2736.6 13780.9 14045.5 14261.3 14664.7 14705.3 1782.5 1789.7 1891.9 1900.8 1978.2 76947.6 77281.0 78238.6 78427.6 79771.0 9236.4 9836.4 9934.4 10411.1 10537.0 12457.4 13366.3 13455.4 13516.3 13518.3 6123.2 6147.1 6173.0 6749.8 7438.3 6410.6 6503.4 6615.3 6790.6 6976.3 4005.3 4055.6 4065.6 4098.6 4119.1 1961.5 1962.7 1973.2 2031.1 2064.7 904.6 936.9 978.9 979.5 1004.7 17643.1 19094.0 19228.8 19537.4 20247.5 948.7 961.4 968.5 984.3 1008.6 10130.8 10555.9 10730.5 10738.6 10993.2 415135.0 417455.0 436686.0 455210.0 456040.0 92567.5 93934.0 95159.0 96844.0 99861.0 1010.1 1033.5 1074.5 1089.5 1095.8 16884.2 16886.2 17385.4 17571.0 17631.0 41591.4 41765.0 42188.8 42541.2 42694.8 59721.0 60278.0 60298.8 61141.7 63384.4 7624.5 7989.0 8341.8 8558.3 8567.4 12784.2 13529.5 13545.1 13615.4 13827.7 11557.7 11596.7 11715.1 11831.9 12120.9 10738.8 11115.9 11127.2 11193.8 11195.8 11542.8 11659.9 11720.9 11945.8 12093.9 7847.1 7938.4 7952.7 8005.9 8054.6 11214.6 11608.8 11663.9 11892.9 11950.3 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:5430.48 Median:4839.14 stddev:3086.34 (63.8%) stddev-sans-first:3080.26 17:10:00 INFO - PROCESS | 2001 | Values: 1416.7 1478.8 1558.2 1706.8 1717.4 7244.8 7429.7 7847.6 8432.4 8501.3 7599.7 7733.7 7749.0 7973.6 7978.9 2220.8 2227.2 2244.7 2249.3 2260.1 2161.6 2174.2 2212.2 2222.3 2225.7 2151.9 2152.4 2156.9 2163.4 2166.2 2116.8 2133.5 2143.0 2143.6 2145.3 2088.5 2161.8 2184.9 2185.8 2191.8 8411.2 8454.5 8457.7 8474.2 8487.1 4968.5 5078.6 5086.6 5093.9 5112.2 3151.3 3236.3 3250.9 3253.0 3258.2 1050.3 1091.5 1091.8 1111.1 1123.3 11299.6 11318.2 11322.9 11341.1 11342.7 4109.2 4405.7 4412.2 4418.5 4438.7 9658.3 9688.4 9709.3 9725.4 9777.3 5088.1 5104.1 5109.3 5111.8 5141.3 4017.0 4520.5 4605.1 4686.1 4727.8 3766.4 3775.8 3874.3 3880.4 3915.8 1237.7 1257.1 1262.1 1272.8 1287.9 805.8 810.2 815.7 922.6 925.3 5221.7 5364.9 5437.8 5538.8 5544.3 416.9 419.8 422.3 422.7 434.5 3608.2 3700.4 3731.9 3735.6 3814.6 10188.7 10304.2 10313.9 10315.0 10356.7 10098.7 10137.6 10153.9 10253.9 10265.4 7595.7 7766.9 7770.6 7779.2 7788.5 5217.3 5368.0 5417.9 5420.2 5513.5 9286.3 9398.8 9466.0 9555.1 9575.1 9026.3 9457.5 9485.3 9486.9 9489.1 6956.2 7105.7 7259.4 7491.4 7686.5 7933.8 8201.5 8260.7 8303.7 8313.2 7296.3 7381.2 7401.9 7487.1 7574.9 7016.6 7061.2 7064.6 7194.5 7295.3 6738.1 6763.2 6780.7 6784.0 6829.6 4688.7 4804.7 4824.8 4853.5 4881.5 4736.4 4762.5 4788.0 4877.1 5038.0 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:4609.27 Median:5179.32 stddev:1334.41 (25.8%) stddev-sans-first:1298.32 17:10:00 INFO - PROCESS | 2001 | Values: 297.7 301.8 310.9 321.2 328.1 5388.1 5459.9 5488.5 5594.7 5639.8 5213.3 5346.9 5380.9 5452.7 5481.3 4260.7 4283.4 4302.3 4306.1 4328.4 4214.9 4249.2 4276.8 4313.4 4314.9 4201.5 4242.2 4251.6 4252.7 4252.8 4239.5 4253.7 4260.4 4291.3 4308.3 3654.8 3804.6 3813.7 3819.3 3827.4 5175.9 5243.7 5251.3 5267.5 5314.6 4791.7 4797.5 4799.5 4824.3 4840.2 5511.8 5605.6 5645.6 5647.3 5675.4 4064.8 4081.7 4082.4 4084.9 4103.6 5922.9 5937.5 5938.8 5944.7 5953.9 4083.3 4104.8 4191.3 4201.8 4218.6 4182.5 4210.9 4221.9 4228.2 4237.2 4797.0 4819.9 4827.7 4828.0 4836.2 5430.6 5713.3 5761.0 5770.3 5779.2 1371.8 1394.9 1396.7 1396.9 1399.5 877.9 896.8 909.0 919.7 922.4 4888.9 4903.0 4907.2 4944.7 4971.5 5098.8 5134.9 5222.4 5241.3 5273.6 4696.2 4743.8 4807.4 4814.5 4945.9 2738.6 2762.4 2762.8 2778.5 2793.7 5338.7 5355.8 5375.8 5385.3 5391.7 4983.7 5152.6 5154.0 5179.6 5182.8 5295.2 5308.0 5325.7 5362.0 5375.0 5179.0 5210.0 5236.3 5251.7 5252.7 4768.3 5023.6 5069.3 5094.7 5197.5 5266.4 5280.5 5311.0 5332.7 5353.5 3751.4 3880.9 3925.4 3992.9 4029.9 5771.5 5776.6 5791.3 5796.4 5832.8 5573.3 5681.2 5697.5 5714.8 5734.8 5595.8 5612.5 5618.4 5619.2 5659.0 5605.2 5612.6 5636.4 5639.6 5675.2 5538.2 5591.0 5676.3 5680.6 5746.5 5570.0 5570.7 5615.8 5631.9 5633.5 17:10:00 INFO - PROCESS | 2001 | 17:10:00 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:19545.61 Median:51570.67 stddev:28496.92 (55.3%) stddev-sans-first:28541.77 17:10:00 INFO - PROCESS | 2001 | Values: 710.7 726.0 764.8 793.3 801.4 15978.8 16796.9 16858.2 16884.6 16942.2 15168.6 15185.7 15206.1 15216.5 15242.8 746.6 752.7 754.4 757.9 758.0 779.8 781.5 783.0 783.2 784.4 818.6 822.4 823.2 828.9 830.5 817.8 817.9 818.6 826.9 827.8 609.6 610.5 610.6 610.9 611.1 14094.6 14212.2 14254.0 14258.9 14268.1 11990.5 12590.7 12601.7 12664.8 12888.9 11921.5 12014.7 12063.2 12068.5 12317.2 4301.7 4341.8 4403.0 4403.3 4459.4 84790.0 85941.0 86318.0 88679.0 89954.0 9653.9 9722.5 9884.8 9937.4 10179.1 18270.9 18288.2 18302.5 18368.8 19255.8 8248.0 8478.9 8621.1 8623.0 8709.3 4633.1 4637.7 4643.3 4659.8 4827.0 3606.6 3731.7 3738.4 3769.2 3804.9 633.4 640.8 641.1 643.0 648.6 688.7 690.1 728.7 733.3 739.9 9085.4 9186.0 9506.0 9537.0 9584.2 587.5 626.8 635.0 684.5 725.1 4463.7 4591.5 4685.3 4869.0 4881.4 112806.0 113032.0 114124.0 115707.0 119275.0 56694.4 57290.0 58376.4 59680.4 62073.7 86865.6 89498.6 90909.0 91465.5 91726.0 8835.7 9008.5 9153.2 9170.8 9247.0 51409.3 51732.0 51887.5 52163.2 53421.7 46450.5 74010.0 74550.0 74828.6 78306.6 11149.2 11307.6 11521.4 11598.8 11738.9 12161.6 12365.5 12371.6 12416.2 12510.9 11922.9 11985.9 12071.9 12171.9 12746.9 11574.3 11596.0 12108.2 12278.9 12542.1 11462.4 11740.9 11744.0 11841.5 12099.3 9827.4 9886.1 10242.2 10296.0 10617.4 10472.7 10720.8 10771.4 10778.2 10794.0 17:10:00 INFO - PROCESS | 2001 | -------- Summary: end -------- 17:10:00 INFO - PROCESS | 2001 | 17:10:01 INFO - TEST-INFO | 2001: exit 0 17:10:01 INFO - TEST-OK | dromaeo_css | took 1114386ms 17:10:01 INFO - TEST-START | kraken 17:10:01 INFO - operating with platform_type : linux_ 17:10:01 INFO - Initialising browser for kraken test... 17:10:01 INFO - TEST-INFO | started process 2434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZXqc0Z/profile http://localhost:37194/getInfo.html) 17:10:06 INFO - PROCESS | 2434 | __metrics Screen width/height:1600/1200 17:10:06 INFO - PROCESS | 2434 | colorDepth:24 17:10:06 INFO - PROCESS | 2434 | Browser inner width/height: 1024/697 17:10:06 INFO - PROCESS | 2434 | __metrics 17:10:06 ERROR - PROCESS | 2434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 17:10:07 INFO - TEST-INFO | 2434: exit 0 17:10:07 INFO - Browser initialized. 17:10:07 INFO - Running cycle 1/1 for kraken test... 17:10:07 INFO - TEST-INFO | started process 2577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZXqc0Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:19 INFO - PROCESS | 2577 | RSS: Main: 185016320 17:10:19 INFO - PROCESS | 2577 | 17:10:22 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37194/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:23 INFO - PROCESS | 2577 | RSS: Main: 199208960 17:10:23 INFO - PROCESS | 2577 | 17:10:25 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37194/tests/kraken/driver.html?testName=audio-dft) 17:10:26 INFO - PROCESS | 2577 | RSS: Main: 196780032 17:10:26 INFO - PROCESS | 2577 | 17:10:29 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37194/tests/kraken/driver.html?testName=audio-fft) 17:10:30 INFO - PROCESS | 2577 | RSS: Main: 193286144 17:10:30 INFO - PROCESS | 2577 | 17:10:32 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37194/tests/kraken/driver.html?testName=audio-oscillator) 17:10:32 INFO - PROCESS | 2577 | RSS: Main: 193269760 17:10:32 INFO - PROCESS | 2577 | 17:10:34 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:35 INFO - PROCESS | 2577 | RSS: Main: 193433600 17:10:35 INFO - PROCESS | 2577 | 17:10:38 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37194/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:39 INFO - PROCESS | 2577 | RSS: Main: 193527808 17:10:39 INFO - PROCESS | 2577 | 17:10:42 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37194/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:43 INFO - PROCESS | 2577 | RSS: Main: 191524864 17:10:43 INFO - PROCESS | 2577 | 17:10:46 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37194/tests/kraken/driver.html?testName=json-parse-financial) 17:10:46 INFO - PROCESS | 2577 | RSS: Main: 192258048 17:10:46 INFO - PROCESS | 2577 | 17:10:48 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:48 INFO - PROCESS | 2577 | RSS: Main: 192860160 17:10:48 INFO - PROCESS | 2577 | 17:10:50 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:51 INFO - PROCESS | 2577 | RSS: Main: 193335296 17:10:51 INFO - PROCESS | 2577 | 17:10:53 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:54 INFO - PROCESS | 2577 | RSS: Main: 193388544 17:10:54 INFO - PROCESS | 2577 | 17:10:56 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:57 INFO - PROCESS | 2577 | RSS: Main: 193458176 17:10:57 INFO - PROCESS | 2577 | 17:11:00 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:01 INFO - PROCESS | 2577 | RSS: Main: 193511424 17:11:01 INFO - PROCESS | 2577 | 17:11:02 INFO - PROCESS | 2577 | Cycle 1(1): loaded http://localhost:37194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37194/tests/kraken/driver.html?testName=ai-astar) 17:11:03 INFO - PROCESS | 2577 | RSS: Main: 194789376 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | __start_tp_report 17:11:03 INFO - PROCESS | 2577 | _x_x_mozilla_page_load 17:11:03 INFO - PROCESS | 2577 | _x_x_mozilla_page_load_details 17:11:03 INFO - PROCESS | 2577 | |i|pagename|runs| 17:11:03 INFO - PROCESS | 2577 | |0;ai-astar;107;113;111;111;112;112;112;112;112;112 17:11:03 INFO - PROCESS | 2577 | |1;audio-beat-detection;155;130;132;163;127;129;128;134;155;132 17:11:03 INFO - PROCESS | 2577 | |2;audio-dft;162;164;164;163;170;165;166;167;163;163 17:11:03 INFO - PROCESS | 2577 | |3;audio-fft;75;75;75;109;79;77;76;77;107;76 17:11:03 INFO - PROCESS | 2577 | |4;audio-oscillator;83;83;108;84;83;83;99;83;83;114 17:11:03 INFO - PROCESS | 2577 | |5;imaging-gaussian-blur;118;119;117;117;119;118;118;118;118;118 17:11:03 INFO - PROCESS | 2577 | |6;imaging-darkroom;148;148;147;146;147;147;148;147;147;148 17:11:03 INFO - PROCESS | 2577 | |7;imaging-desaturate;96;97;97;96;96;97;95;96;96;96 17:11:03 INFO - PROCESS | 2577 | |8;json-parse-financial;55;54;55;53;60;59;55;57;57;55 17:11:03 INFO - PROCESS | 2577 | |9;json-stringify-tinderbox;61;62;62;62;63;63;63;62;62;62 17:11:03 INFO - PROCESS | 2577 | |10;stanford-crypto-aes;80;83;86;81;87;80;81;80;82;80 17:11:03 INFO - PROCESS | 2577 | |11;stanford-crypto-ccm;148;136;149;130;138;137;143;141;190;144 17:11:03 INFO - PROCESS | 2577 | |12;stanford-crypto-pbkdf2;174;170;170;171;170;169;169;177;168;172 17:11:03 INFO - PROCESS | 2577 | |13;stanford-crypto-sha256-iterative;69;67;67;67;69;67;66;66;67;66 17:11:03 INFO - PROCESS | 2577 | __end_tp_report 17:11:03 INFO - PROCESS | 2577 | __start_cc_report 17:11:03 INFO - PROCESS | 2577 | _x_x_mozilla_cycle_collect,762 17:11:03 INFO - PROCESS | 2577 | __end_cc_report 17:11:03 INFO - PROCESS | 2577 | __startTimestamp1475626263020__endTimestamp 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ------- Summary: start ------- 17:11:03 INFO - PROCESS | 2577 | Number of tests: 14 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.65 (1.5%) stddev-sans-first:0.60 17:11:03 INFO - PROCESS | 2577 | Values: 107.0 113.0 111.0 111.0 112.0 112.0 112.0 112.0 112.0 112.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:133.00 stddev:13.56 (10.2%) stddev-sans-first:13.00 17:11:03 INFO - PROCESS | 2577 | Values: 155.0 130.0 132.0 163.0 127.0 129.0 128.0 134.0 155.0 132.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.41 (1.5%) stddev-sans-first:2.35 17:11:03 INFO - PROCESS | 2577 | Values: 162.0 164.0 164.0 163.0 170.0 165.0 166.0 167.0 163.0 163.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.45 (17.7%) stddev-sans-first:13.98 17:11:03 INFO - PROCESS | 2577 | Values: 75.0 75.0 75.0 109.0 79.0 77.0 76.0 77.0 107.0 76.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.00 stddev:12.07 (14.5%) stddev-sans-first:12.50 17:11:03 INFO - PROCESS | 2577 | Values: 83.0 83.0 108.0 84.0 83.0 83.0 99.0 83.0 83.0 114.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:11:03 INFO - PROCESS | 2577 | Values: 118.0 119.0 117.0 117.0 119.0 118.0 118.0 118.0 118.0 118.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:11:03 INFO - PROCESS | 2577 | Values: 148.0 148.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 148.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:11:03 INFO - PROCESS | 2577 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.21 (3.9%) stddev-sans-first:2.32 17:11:03 INFO - PROCESS | 2577 | Values: 55.0 54.0 55.0 53.0 60.0 59.0 55.0 57.0 57.0 55.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 17:11:03 INFO - PROCESS | 2577 | Values: 61.0 62.0 62.0 62.0 63.0 63.0 63.0 62.0 62.0 62.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:2.58 (3.2%) stddev-sans-first:2.64 17:11:03 INFO - PROCESS | 2577 | Values: 80.0 83.0 86.0 81.0 87.0 80.0 81.0 80.0 82.0 80.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:143.50 stddev:16.62 (11.6%) stddev-sans-first:17.61 17:11:03 INFO - PROCESS | 2577 | Values: 148.0 136.0 149.0 130.0 138.0 137.0 143.0 141.0 190.0 144.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.50 stddev:2.71 (1.6%) stddev-sans-first:2.65 17:11:03 INFO - PROCESS | 2577 | Values: 174.0 170.0 170.0 171.0 170.0 169.0 169.0 177.0 168.0 172.0 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:0.93 17:11:03 INFO - PROCESS | 2577 | Values: 69.0 67.0 67.0 67.0 69.0 67.0 66.0 66.0 67.0 66.0 17:11:03 INFO - PROCESS | 2577 | -------- Summary: end -------- 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | 17:11:03 INFO - PROCESS | 2577 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:11:03 INFO - PROCESS | 2577 | 17:11:04 INFO - TEST-INFO | 2577: exit 0 17:11:04 INFO - TEST-OK | kraken | took 62479ms 17:11:04 INFO - SUITE-END | took 1176s 17:11:04 INFO - Completed test suite (00:19:36) 17:11:04 INFO - javascript benchmark 17:11:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7024.547465430167, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.769617278704, 3076.215565030917, 3089.4902341113716, 3113.972389111593, 3115.2834847984977, 5132.230165475181, 5302.337207849019, 5321.068812957731, 5378.677279363236, 5401.945980540203, 5184.248283998818, 5272.051030814452, 5363.302770639821, 5434.91847622285, 5449.128139497681, 4790.784414701347, 4816.614670826326, 4901.485344038878, 4925.778339974692, 4990.775415106329, 4842.29786680931, 4921.384826896638, 5029.622778291643, 5034.043531728978, 5053.823116190934, 4790.065937142259, 4833.540813622701, 4864.8297309594345, 4877.780499877496, 4878.414590249157, 4869.464358920516, 4909.607231421478, 4927.433345165316, 4961.156603377434, 4976.154053810861, 4857.429927588946, 4876.7808047988, 4876.853694389174, 4896.216605343164, 4958.0, 5118.360204974379, 5206.843794686166, 5308.256844041837, 5345.1447768356875, 5383.138697808332, 5562.749676264578, 5635.6055076144685, 5641.943580564182, 5665.830025099253, 5738.110592858114, 5670.6030577859565, 5672.773089076432, 5712.542996560265, 5730.7421166047625, 5731.111677689964, 5211.817586384458, 5308.867278318073, 5310.92033619496, 5322.1484562470205, 5352.732363381815, 5731.083026715705, 5751.827445176651, 5783.595148339576, 5800.53595712342, 5892.94107058924, 5569.554435645138, 5580.330360356783, 5586.13414920688, 5595.8601034973635, 5645.266115404971, 5594.0769772987815, 5605.887882242332, 5702.572307076903, 5714.5999780015, 5718.599698021182, 5505.6696598204235, 5517.337919449692, 5551.444855514416, 5571.777128914798, 5608.074667679869, 5725.8568535786935, 5733.426657334317, 5739.71301434935, 5744.281964754406, 5780.16187652788, 4389.056352884145, 4399.274119770266, 4401.823927042882, 4426.9778651106535, 4459.576340247671, 3827.5024246847734, 3848.4034974578985, 3866.4586957825927, 3897.7661340319673, 3954.031262340745, 5405.162199859028, 5443.646162999393, 5464.863378415572, 5494.945050549443, 5546.362168350692, 5688.146777983253, 5710.942890571041, 5739.569532285095, 5755.9424405756245, 5758.3090029196765, 5245.501677340647, 5270.49930256625, 5396.946030539723, 5472.2338872557875, 5482.753276102585, 4912.6561140719805, 4934.0, 4961.4046314441775, 4966.379202599675, 4969.950300497021, 5945.137954996588, 5946.524278057745, 5947.821565353046, 5953.0, 5958.314793798769, 5545.390007099297, 5619.353774316006, 5742.799002034909, 5748.741306641127, 5754.3670196277535, 5859.94140058594, 5897.823065308047, 5944.405559444021, 5956.37458066914, 6032.607880487754, 5619.0, 5654.830355089354, 5663.32040155184, 5673.74468148926, 5678.517326027334, 5423.132298832168, 5707.514861236841, 5761.827145185651, 5763.221965034667, 5782.913256301074, 5315.893682126413, 5543.113101903676, 5591.552675786009, 5606.775728970795, 5688.288963879515, 5579.6652200868075, 5596.048671725898, 5596.916046259391, 5624.57815663835, 5625.071863142699, 5289.47105289468, 5320.866978325573, 5510.063289240758, 5540.085885828793, 5591.692456914909, 5585.609007369608, 5609.49514543693, 5616.1014237721765, 5650.124230744241, 5716.456936591017, 5458.5087342139395, 5475.780968761205, 5477.863053423696, 5509.0, 5518.117101263779], "value": 5263.963637964538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7271364317841, 550.2516577454661, 560.4759549820915, 562.3083607163187, 567.452408425869, 40465.59534404659, 42576.36135457967, 42648.93377665556, 46558.53441465584, 46607.30089048667, 44156.779216103954, 44668.0, 44714.55285447145, 44718.55281447185, 44736.0, 8759.474431534112, 8994.235489983359, 9021.0, 9021.819563608757, 9023.639054437816, 8824.02935677075, 8865.734027979172, 8867.645294188225, 8905.866412003825, 8961.417507862001, 8868.157525035143, 8894.066123057082, 8899.154580314893, 8922.10778922109, 8942.73171804847, 8848.292136629087, 8880.689175878846, 8917.242034427081, 8960.731178064669, 8987.685431009882, 7024.473164512631, 7097.751578694721, 7099.077119974422, 7101.254368291358, 7105.644717764091, 41347.0, 41881.0, 41938.0, 42041.36937945903, 42098.36852447216, 3192.6488086310487, 3332.150301673082, 3415.4023045966856, 3779.7321607035833, 3795.3168429682646, 30441.847790760905, 30890.536641950388, 30973.0, 31213.375732485223, 31242.218944526343, 4220.85227017053, 4350.15172041452, 4370.497392799837, 4381.693281470299, 4419.116176764628, 353746.0, 355081.22459387797, 355649.0, 357291.0, 357346.0, 58701.412985869596, 59062.704686476296, 59086.27309815204, 59088.7045564778, 59199.304090467966, 61968.07047894285, 62057.0, 62225.37774622286, 62263.37736622666, 62408.0, 14193.432262709583, 14225.928870355581, 14231.359588818528, 14280.642983925485, 14311.284435778169, 12424.316662583464, 12473.438695258736, 12484.375781210903, 12512.186707863959, 12523.686907827378, 14066.367013484418, 15918.283677234553, 18199.0, 18340.174692138884, 18348.055168138915, 6852.738596263222, 6960.547564408398, 6960.965195174093, 7211.12510747199, 7407.222241664547, 914.264017465933, 985.9753506162403, 1065.4588805698465, 1090.2477290669412, 1103.2442776697987, 30560.235994100327, 30660.080197594107, 30684.232894177378, 31177.688223117933, 31516.842415787774, 983.5623147699348, 1057.471264367816, 1063.4470075560819, 1119.7536541960756, 1162.5291756838494, 15461.304241309168, 15702.136382498844, 15785.763213551805, 15823.0, 16306.75539866903, 580420.0, 583110.0, 584751.0, 588501.0, 590553.0, 55718.0, 55763.44236557664, 56493.0, 56896.0, 57041.0, 1286.3632501911427, 1301.5704817410233, 1302.1861336664585, 1320.6764342735898, 1329.2954733991, 28149.71850281553, 28775.424491510472, 28789.424211515234, 29454.852725736233, 30224.84887575548, 47933.0, 48348.5165148344, 48429.5157048425, 48530.757346213046, 48660.5133948656, 465939.0, 466918.0, 467500.0, 467688.0, 467819.0, 27127.1861844145, 27644.723552764215, 27741.72258277472, 27798.722012779614, 28067.157985260474, 45371.77314113409, 45557.31664024976, 45978.31032534582, 46308.7684561575, 46859.76570117127, 38774.6122538771, 38997.805010974764, 39331.2133757329, 40005.79997099996, 41020.79489602533, 38879.41680874732, 39632.40551391674, 39830.40254396128, 40189.0, 41964.580354197285, 39393.0, 39572.20855582815, 39625.40561891632, 39862.60137398705, 40563.0, 34063.31873362469, 35826.64173358233, 36294.0, 36453.45319820152, 36573.634263657026, 27546.44907101887, 27741.583876241468, 27791.44417111687, 27802.0, 27843.0], "value": 19602.28283658905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9059425737823, 397.1877510491046, 397.84682897084616, 398.8564116917909, 430.76953829701114, 18086.638267234648, 18481.630367392645, 18713.625727485458, 18725.438236852882, 19533.609327813436, 18476.538086547844, 18689.0, 18812.30689237972, 19139.138738756756, 19202.807971920276, 5604.663720176782, 5621.634593751413, 5821.417858214166, 5880.4119588041285, 5882.205902203212, 5726.885462290752, 5823.213866128082, 5826.708664566776, 5826.9708651456895, 5840.474357307841, 5550.306211723535, 5720.942790572103, 5760.855978600547, 5781.479666829984, 5789.884202315951, 5762.596618236725, 5783.595148339597, 5849.151872978437, 5855.47300742933, 5870.73581688825, 5092.465291144451, 5184.818531351385, 5205.6616319939085, 5213.357792295453, 5214.843554693365, 22424.103035878547, 22554.097836086537, 22657.0, 22858.19996300138, 22895.885520572458, 2265.5808675395106, 2271.46620544172, 2317.6291793313158, 2554.693436787579, 2736.58951157326, 13780.862191378059, 14045.532932108134, 14261.28693565328, 14664.706705865823, 14705.338259778335, 1782.4563508130016, 1789.677857985562, 1891.867569270138, 1900.7624046994126, 1978.1800743316185, 76947.61526192389, 77281.0, 78238.60880695617, 78427.60786196032, 79771.0, 9236.445813251092, 9836.3606365586, 9934.354266972623, 10411.11505522039, 10537.0, 12457.377131143588, 13366.33168341579, 13455.443465741673, 13516.324183790772, 13518.324083795771, 6123.173371594867, 6147.139400483936, 6173.0, 6749.763758268437, 7438.256174382518, 6410.61536307823, 6503.447206987365, 6615.338466153443, 6790.558613690095, 6976.337247961435, 4005.339119045383, 4055.614716601918, 4065.6340929316502, 4098.590140985937, 4119.114390406017, 1961.4900125967351, 1962.6957821537685, 1973.2205778717325, 2031.1063132221775, 2064.721262629526, 904.6245807989742, 936.9109934556207, 978.9265805064649, 979.5004547680734, 1004.6835246897203, 17643.117844108, 19094.0, 19228.807711922982, 19537.413877583695, 20247.4938126548, 948.7248697877676, 961.3606951377395, 968.5496244246459, 984.3306551544875, 1008.621766837436, 10130.848037279447, 10555.894441055645, 10730.463476826128, 10738.570457181782, 10993.175511836644, 415135.0, 417455.0, 436686.0, 455210.0, 456040.0, 92567.53716231376, 93934.0, 95159.0, 96844.0, 99861.0, 1010.1060561403211, 1033.534909290807, 1074.5486895503907, 1089.4824958144818, 1095.8356246562919, 16884.227156148918, 16886.24011919442, 17385.391511297043, 17571.0, 17631.0, 41591.37612935748, 41765.0, 42188.78905605452, 42541.1934090544, 42694.78652606717, 59721.0, 60278.0, 60298.81914232443, 61141.694291528256, 63384.36615633785, 7624.504407213513, 7989.0, 8341.791455213668, 8558.315334773328, 8567.443116197428, 12784.169029013085, 13529.526466573623, 13545.1195672281, 13615.387307571382, 13827.723445531234, 11557.653270401901, 11596.710082248012, 11715.121365897421, 11831.940840295743, 12120.939395302967, 10738.785224295314, 11115.88841115882, 11127.221094523306, 11193.776124477303, 11195.793955810586, 11542.82685759731, 11659.941700291443, 11720.941395292968, 11945.820812687643, 12093.939530302292, 7847.0975837777105, 7938.444308898322, 7952.681892724227, 8005.919940800517, 8054.637541310538, 11214.607488737855, 11608.767824643292, 11663.941680291544, 11892.881071189177, 11950.282983021047], "value": 9038.862984008267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.7237388709202, 1478.807754991851, 1558.2286768049817, 1706.8378504042112, 1717.4418314047937, 7244.7826565202995, 7429.665665045072, 7847.568383738892, 8432.409731318803, 8501.319894408449, 7599.696012159521, 7733.651985660645, 7748.96125519373, 7973.561454120021, 7978.92021079789, 2220.822334213259, 2227.2204728345114, 2244.7194100737406, 2249.302716157996, 2260.1298500077505, 2161.5676864627058, 2174.1629472652985, 2212.1814928476488, 2222.288867562381, 2225.688403623494, 2151.8816465094415, 2152.4080877758665, 2156.892155392232, 2163.448320678233, 2166.2093335932427, 2116.8412369072225, 2133.519958009443, 2142.9785702142935, 2143.603433364825, 2145.302776597612, 2088.4778805298674, 2161.7838216178416, 2184.934451966428, 2185.7595664476894, 2191.7808219177955, 8411.242988131098, 8454.492730436132, 8457.746267611981, 8474.237318641352, 8487.06642269356, 4968.453470118284, 5078.64449488536, 5086.593072554187, 5093.898122037538, 5112.18205087188, 3151.2909595341093, 3236.3203727217315, 3250.9349813003846, 3252.9837350813095, 3258.152880251128, 1050.3277902142636, 1091.5142761471147, 1091.8307662312354, 1111.1333160135027, 1123.3260043973632, 11299.604513841976, 11318.151138664633, 11322.943385283103, 11341.149413793999, 11342.659720208407, 4109.178164367138, 4405.713628614129, 4412.227860124465, 4418.497710778351, 4438.667099967515, 9658.323917325719, 9688.41869487833, 9709.320347575602, 9725.367851089657, 9777.31558790892, 5088.135017047037, 5104.132297509433, 5109.335786347825, 5111.846644600668, 5141.331626888481, 4016.979915100464, 4520.525344838745, 4605.125026245003, 4686.109639168615, 4727.787249573777, 3766.4350347448103, 3775.7734535927934, 3874.283257597297, 3880.3985382265796, 3915.8433662653742, 1237.7400745843474, 1257.126297223421, 1262.059765474727, 1272.7518133963788, 1287.8647741987145, 805.7502174325978, 810.2343285595056, 815.6778072661266, 922.5710044829052, 925.2736601767715, 5221.7128057956415, 5364.892702145935, 5437.8368648940595, 5538.778448862081, 5544.279243698374, 416.85826818881725, 419.82367405689683, 422.2715815218723, 422.7400148908399, 434.4721163786015, 3608.2061946371755, 3700.40793473043, 3731.9440208396354, 3735.589085200626, 3814.5803961564206, 10188.745281368025, 10304.175665946706, 10313.896861031444, 10315.0, 10356.741081473023, 10098.747531311776, 10137.64518241858, 10153.949230253802, 10253.948730256301, 10265.435401053013, 7595.6961721531625, 7766.922330776733, 7770.611469426506, 7779.222077792176, 7788.454808163374, 5217.269582258563, 5367.973160134175, 5417.918731218956, 5420.186971954238, 5513.5037846594, 9286.257099432165, 9398.812023759623, 9465.952670236606, 9555.140037396668, 9575.09036641518, 9026.277897768032, 9457.527123643653, 9485.33602647808, 9486.85769713441, 9489.051094890456, 6956.234814170539, 7105.680244388912, 7259.382952449101, 7491.400687945061, 7686.46194766361, 7933.761987140395, 8201.466904651179, 8260.710875119583, 8303.6678532858, 8313.168683131638, 7296.270372962661, 7381.151167615578, 7401.888971665537, 7487.138979017483, 7574.924250757643, 7016.614086225102, 7061.152661680631, 7064.646767661494, 7194.496385252982, 7295.343419092307, 6738.090357801634, 6763.188417389944, 6780.660966951731, 6784.0, 6829.624370659462, 4688.718676879398, 4804.735739534359, 4824.782884770124, 4853.49038350968, 4881.51184881509, 4736.360591320127, 4762.52374762521, 4788.0, 4877.097736918681, 5038.0], "value": 4282.593707211615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.72609199536424, 301.7585931254996, 310.8725422576744, 321.21463022908983, 328.06665037966974, 5388.141091323487, 5459.863503412406, 5488.451154884509, 5594.692291923948, 5639.802606908754, 5213.348331458567, 5346.893062138755, 5380.946190538093, 5452.727363631812, 5481.287432633762, 4260.72305300156, 4283.443152390185, 4302.311630139178, 4306.117245964578, 4328.394024836525, 4214.936775948363, 4249.192653395845, 4276.786160691969, 4313.374560688699, 4314.913701725964, 4201.474815648044, 4242.2182683273095, 4251.59609837065, 4252.723572967747, 4252.766097864616, 4239.491261048663, 4253.702240843142, 4260.42484264625, 4291.270484017725, 4308.328836121625, 3654.798986055766, 3804.600516945736, 3813.733038687293, 3819.2934307153264, 3827.4067519534515, 5175.896482070375, 5243.692775178947, 5251.343582052244, 5267.499587539178, 5314.5748340132695, 4791.664583479158, 4797.544233297831, 4799.544043315879, 4824.276358546211, 4840.2255639097575, 5511.807086751985, 5605.607607467479, 5645.645045189125, 5647.265855438808, 5675.3757086720425, 4064.7764372959773, 4081.7346622547107, 4082.4284600156, 4084.8774536763945, 4103.589641035903, 5922.881542369171, 5937.524998000193, 5938.7624495020145, 5944.7324870380935, 5953.851153721148, 4083.2650122977557, 4104.835806567764, 4191.287481128215, 4201.810918508674, 4218.557051509609, 4182.519010313792, 4210.936835947463, 4221.9023054005565, 4228.175505776344, 4237.237297286456, 4796.952030479721, 4819.927701084486, 4827.662063655511, 4827.95172048275, 4836.153673107192, 5430.565554755689, 5713.314402271754, 5761.0, 5770.307563092372, 5779.1506717850725, 1371.7530844447895, 1394.9302534873216, 1396.7066915947562, 1396.860313968595, 1399.531157062375, 877.8990416102102, 896.8430524658289, 908.9727308180766, 919.7194855568982, 922.4419226368085, 4888.853334399973, 4903.0, 4907.2393778964315, 4944.703317800943, 4971.45314015458, 5098.821541246039, 5134.87162820925, 5222.3733152022005, 5241.292425522582, 5273.551748101378, 4696.2486002239475, 4743.833965811249, 4807.375041244616, 4814.470408255089, 4945.876353091202, 2738.6439762830705, 2762.392273699783, 2762.8480433575946, 2778.499610210504, 2793.706660800627, 5338.731039308278, 5355.839324820262, 5375.75809088592, 5385.3268341457315, 5391.73041347931, 4983.651144419856, 5152.587792976553, 5154.0, 5179.637425380187, 5182.797311142749, 5295.179247216687, 5308.0, 5325.680459172385, 5362.0, 5375.0, 5179.0, 5209.973950130225, 5236.319278493771, 5251.737413129405, 5252.684838909678, 4768.3085952537385, 5023.598112150946, 5069.3156423883775, 5094.719790411563, 5197.532222100029, 5266.368035835724, 5280.471952804843, 5310.9734451327495, 5332.70670113132, 5353.457107873729, 3751.3869036313554, 3880.9417858731576, 3925.3523168676847, 3992.940105898356, 4029.8992525187105, 5771.509421699203, 5776.566757493289, 5791.333996590278, 5796.362400135898, 5832.833433313439, 5573.331200255833, 5681.2330335404195, 5697.515711164431, 5714.771409143587, 5734.770609175586, 5595.832125036255, 5612.466815652507, 5618.381977982501, 5619.157126431068, 5659.0, 5605.178317047057, 5612.635178713371, 5636.351819540805, 5639.605227634026, 5675.177099320658, 5538.224648549126, 5590.957858229964, 5676.318841739017, 5680.602357834912, 5746.511546518593, 5569.972150139385, 5570.690887641482, 5615.831525054255, 5631.915521267102, 5633.492985631313], "value": 4174.206072287215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7441321124396, 725.9691238441412, 764.7896828372195, 793.3098204562032, 801.4269797095076, 15978.84021159788, 16796.916015419938, 16858.15709214539, 16884.577885552866, 16942.23759930803, 15168.620784480367, 15185.722141678754, 15206.087634741923, 15216.467423640175, 15242.847571524282, 746.5781833264216, 752.7102065704715, 754.4266357568233, 757.9090509138883, 757.9886301705465, 779.8479296537178, 781.4920301803816, 783.0173132718459, 783.1972228465811, 784.3881772217651, 818.6193420059672, 822.3873214455209, 823.1685997142869, 828.9336853051772, 830.4602008694367, 817.8200795824908, 817.8732296494053, 818.5988865455884, 826.9379796515256, 827.7847759582492, 609.5946195779801, 610.5390430225151, 610.6092101055284, 610.9358517355703, 611.0864257934372, 14094.647633809236, 14212.218327991955, 14254.0, 14258.928705356511, 14268.143911365247, 11990.520379184822, 12590.68523286916, 12601.747965040648, 12664.81002784959, 12888.871111288861, 11921.463534140985, 12014.65347920176, 12063.21589096706, 12068.456919438646, 12317.199382040228, 4301.677374196947, 4341.804618792162, 4403.031333106712, 4403.2954727243805, 4459.397981272519, 84790.0, 85940.99999999937, 86318.0, 88679.0, 89953.99999999935, 9653.9034609653, 9722.513874306256, 9884.802303954024, 9937.354071985443, 10179.134773544183, 18270.903745775297, 18288.17703203359, 18302.54243643893, 18368.816311836978, 19255.8074419254, 8247.95876020628, 8478.872816907751, 8621.137886211329, 8623.0, 8709.259712924346, 4633.119707255611, 4637.721736695809, 4643.303504474288, 4659.790309436084, 4827.0, 3606.5672119345845, 3731.738778285494, 3738.420544815558, 3769.246150769857, 3804.923901521954, 633.3508154141949, 640.8365866704054, 641.1056576076347, 642.9839254018686, 648.6043513456788, 688.7141836137947, 690.102866273842, 728.6757392960081, 733.3033618062861, 739.8705226585326, 9085.409448385966, 9185.95407022974, 9505.952470237604, 9536.952315238519, 9584.233261339075, 587.465406480101, 626.7837596029362, 634.9682515874188, 684.4661164291861, 725.0682872508801, 4463.687541872037, 4591.540845915381, 4685.250359942393, 4868.95690193629, 4881.438634557071, 112806.0, 113032.0, 114124.0, 115707.0, 119275.0, 56694.43305566974, 57290.0, 58376.41623583795, 59680.403195968356, 62073.68963155246, 86865.5656721725, 89498.55250723705, 90909.0, 91465.54267228622, 91726.0, 8835.668891165315, 9008.504532250789, 9153.17621414076, 9170.816583668422, 9247.0, 51409.33447540939, 51732.0, 51887.48112518978, 52163.217551735994, 53421.7328913353, 46450.535494644624, 74010.0, 74550.0, 74828.62585687036, 78306.6084669573, 11149.219554631098, 11307.604233851776, 11521.366324851879, 11598.826017609574, 11738.88261117412, 12161.574344897886, 12365.505379784709, 12371.628851134481, 12416.192947458387, 12510.87489125097, 11922.940385298365, 11985.880141198477, 12071.939640301742, 12171.939140304241, 12746.936265318614, 11574.305541667527, 11596.0, 12108.21296615717, 12278.938605306916, 12542.12205145631, 11462.4268786562, 11740.941295293469, 11744.0, 11841.526338946345, 12099.274043557414, 9827.4103553787, 9886.110250077527, 10242.180625549789, 10296.0, 10617.362958222531, 10472.738181545523, 10720.785584288427, 10771.353718776898, 10778.245522813328, 10794.0], "value": 7205.241563359199, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 132.0, 163.0, 127.0, 129.0, 128.0, 134.0, 155.0, 132.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 163.0, 170.0, 165.0, 166.0, 167.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 79.0, 77.0, 76.0, 77.0, 107.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 83.0, 83.0, 99.0, 83.0, 83.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 60.0, 59.0, 55.0, 57.0, 57.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 86.0, 81.0, 87.0, 80.0, 81.0, 80.0, 82.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 136.0, 149.0, 130.0, 138.0, 137.0, 143.0, 141.0, 190.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 170.0, 171.0, 170.0, 169.0, 169.0, 177.0, 168.0, 172.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 69.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 67.1, "unit": "score"}]}]} 17:11:04 INFO - Return code: 0 17:11:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:11:04 ERROR - # TBPL SUCCESS # 17:11:04 INFO - Running post-action listener: _resource_record_post_action 17:11:04 INFO - [mozharness: 2016-10-05 00:11:04.324277Z] Finished run-tests step (success) 17:11:04 INFO - Running post-run listener: _resource_record_post_run 17:11:04 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399306752; Read time: 16; Write time: 300956 17:11:04 INFO - TinderboxPrint: CPU usage
13.4% 17:11:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:11:04 INFO - TinderboxPrint: I/O write bytes / time
399,306,752 / 300,956 17:11:04 INFO - TinderboxPrint: CPU idle
8,242.4 (86.6%) 17:11:04 INFO - TinderboxPrint: CPU user
1,218.5 (12.8%) 17:11:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:11:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111071232; Read time: 0; Write time: 85948 17:11:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288235520; Read time: 0; Write time: 215008 17:11:04 INFO - Running post-run listener: _upload_blobber_files 17:11:04 INFO - Blob upload gear active. 17:11:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:11:04 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 17:11:04 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:11:04 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:11:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:09 INFO - (blobuploader) - INFO - Done attempting. 17:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:10 INFO - (blobuploader) - INFO - Done attempting. 17:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:11 INFO - (blobuploader) - INFO - Done attempting. 17:11:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:11 INFO - Return code: 0 17:11:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:11:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e3f0f05da3fc78f407221cce8750ae59598b1ace9d663f75838d26283fe6438f4d21b85649edde49f6456133595f7f31bef88cf6039e93cbb05be0d300ae5bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67d4954e3a95925a2b05bb046df2caff944354a4545dd915227e388d2aee9c99c5b60ca71792dcd0d3369e0366483eefbb30ef21f769396f896e07cbd637a0b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fb38697d15cb45fa0375e2685394ad523517c12e63edeccd001677639569c2eded06086af82ae0b153fcc45b91817c0072f35f40951dea0870ca0e576214f53"} 17:11:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:11:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:11:11 INFO - Contents: 17:11:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e3f0f05da3fc78f407221cce8750ae59598b1ace9d663f75838d26283fe6438f4d21b85649edde49f6456133595f7f31bef88cf6039e93cbb05be0d300ae5bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67d4954e3a95925a2b05bb046df2caff944354a4545dd915227e388d2aee9c99c5b60ca71792dcd0d3369e0366483eefbb30ef21f769396f896e07cbd637a0b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fb38697d15cb45fa0375e2685394ad523517c12e63edeccd001677639569c2eded06086af82ae0b153fcc45b91817c0072f35f40951dea0870ca0e576214f53"} 17:11:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:11 INFO - Copying logs to upload dir... 17:11:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:11:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.883777 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-04 17:11:11.007615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:11.011111) ========= 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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 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/Autoland/sha512/2e3f0f05da3fc78f407221cce8750ae59598b1ace9d663f75838d26283fe6438f4d21b85649edde49f6456133595f7f31bef88cf6039e93cbb05be0d300ae5bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67d4954e3a95925a2b05bb046df2caff944354a4545dd915227e388d2aee9c99c5b60ca71792dcd0d3369e0366483eefbb30ef21f769396f896e07cbd637a0b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fb38697d15cb45fa0375e2685394ad523517c12e63edeccd001677639569c2eded06086af82ae0b153fcc45b91817c0072f35f40951dea0870ca0e576214f53"} build_url:https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e3f0f05da3fc78f407221cce8750ae59598b1ace9d663f75838d26283fe6438f4d21b85649edde49f6456133595f7f31bef88cf6039e93cbb05be0d300ae5bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67d4954e3a95925a2b05bb046df2caff944354a4545dd915227e388d2aee9c99c5b60ca71792dcd0d3369e0366483eefbb30ef21f769396f896e07cbd637a0b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fb38697d15cb45fa0375e2685394ad523517c12e63edeccd001677639569c2eded06086af82ae0b153fcc45b91817c0072f35f40951dea0870ca0e576214f53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:11.037849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:11.038165) ========= 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=1f5564757af27664ca02d71f000001b0-1475625032.46627-587601825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:11.122735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:11:11.123086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:11:11.123397) ========= ========= Total master_lag: 0.17 =========